builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0303 starttime: 1472562784.34 results: success (0) buildid: 20160830043321 builduid: c7cf27e69f6e4cdab6a88c4f9962c937 revision: 74516f0a4d8af50879c733489d16bdcea0bc8655 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.342219) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.342786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.343208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.370866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.371277) ========= 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.n0ljApupab/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.OZSBOKmjXg/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-30 06:13:04-- 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.1M=0.001s 2016-08-30 06:13:04 (18.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.569467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.569782) ========= 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.n0ljApupab/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.OZSBOKmjXg/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.026290 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:04.618148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 06:13:04.618826) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 74516f0a4d8af50879c733489d16bdcea0bc8655 --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 74516f0a4d8af50879c733489d16bdcea0bc8655 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.n0ljApupab/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.OZSBOKmjXg/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-30 06:13:04,700 truncating revision to first 12 chars 2016-08-30 06:13:04,700 Setting DEBUG logging. 2016-08-30 06:13:04,700 attempt 1/10 2016-08-30 06:13:04,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/74516f0a4d8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 06:13:05,727 unpacking tar archive at: autoland-74516f0a4d8a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 06:13:05.926769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:05.927107) ========= script_repo_revision: 74516f0a4d8af50879c733489d16bdcea0bc8655 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:05.927522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:05.927791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 06:13:05.946730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-30 06:13:05.947228) ========= /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.n0ljApupab/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.OZSBOKmjXg/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:13:06 INFO - MultiFileLogger online at 20160830 06:13:06 in /builds/slave/test 06:13:06 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 06:13:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:13:06 INFO - {'append_to_log': False, 06:13:06 INFO - 'base_work_dir': '/builds/slave/test', 06:13:06 INFO - 'blob_upload_branch': 'Autoland', 06:13:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:13:06 INFO - 'branch': 'Autoland', 06:13:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:13:06 INFO - 'config_files': ('talos/mac_config.py',), 06:13:06 INFO - 'default_actions': ('clobber', 06:13:06 INFO - 'read-buildbot-config', 06:13:06 INFO - 'download-and-extract', 06:13:06 INFO - 'populate-webroot', 06:13:06 INFO - 'create-virtualenv', 06:13:06 INFO - 'install', 06:13:06 INFO - 'run-tests'), 06:13:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:13:06 INFO - 'download_minidump_stackwalk': True, 06:13:06 INFO - 'download_symbols': 'ondemand', 06:13:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:13:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:13:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:13:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:13:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:13:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:13:06 INFO - 'installer_path': 'installer.exe', 06:13:06 INFO - 'log_level': 'info', 06:13:06 INFO - 'log_name': 'talos', 06:13:06 INFO - 'log_to_console': True, 06:13:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:13:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:13:06 INFO - 'opt_config_files': (), 06:13:06 INFO - 'pip_index': False, 06:13:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:06 INFO - 'cmd': ('bash', 06:13:06 INFO - '-c', 06:13:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:06 INFO - 'enabled': True, 06:13:06 INFO - 'halt_on_failure': False, 06:13:06 INFO - 'name': 'check_screen_resolution'},), 06:13:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:06 INFO - 'cmd': ('bash', 06:13:06 INFO - '-c', 06:13:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:06 INFO - 'enabled': True, 06:13:06 INFO - 'halt_on_failure': False, 06:13:06 INFO - 'name': 'check_screen_resolution'},), 06:13:06 INFO - 'run_cmd_checks_enabled': True, 06:13:06 INFO - 'sps_profile': False, 06:13:06 INFO - 'sps_profile_interval': 0, 06:13:06 INFO - 'suite': 'dromaeojs-e10s', 06:13:06 INFO - 'system_bits': '32', 06:13:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:13:06 INFO - 'title': 't-yosemite-r7-0303', 06:13:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:13:06 INFO - 'use_talos_json': True, 06:13:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:13:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:13:06 INFO - 'work_dir': 'build'} 06:13:06 INFO - [mozharness: 2016-08-30 13:13:06.138205Z] Running clobber step. 06:13:06 INFO - Running pre-action listener: _resource_record_pre_action 06:13:06 INFO - Running main action method: clobber 06:13:06 INFO - rmtree: /builds/slave/test/build 06:13:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:13:08 INFO - Running post-action listener: _resource_record_post_action 06:13:08 INFO - [mozharness: 2016-08-30 13:13:08.607277Z] Finished clobber step (success) 06:13:08 INFO - [mozharness: 2016-08-30 13:13:08.607446Z] Running read-buildbot-config step. 06:13:08 INFO - Running pre-action listener: _resource_record_pre_action 06:13:08 INFO - Running main action method: read_buildbot_config 06:13:08 INFO - Using buildbot properties: 06:13:08 INFO - { 06:13:08 INFO - "project": "", 06:13:08 INFO - "product": "firefox", 06:13:08 INFO - "script_repo_revision": "production", 06:13:08 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 06:13:08 INFO - "repository": "", 06:13:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 06:13:08 INFO - "buildid": "20160830043321", 06:13:08 INFO - "pgo_build": "False", 06:13:08 INFO - "basedir": "/builds/slave/test", 06:13:08 INFO - "buildnumber": 159, 06:13:08 INFO - "slavename": "t-yosemite-r7-0303", 06:13:08 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 06:13:08 INFO - "platform": "yosemite_r7", 06:13:08 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 06:13:08 INFO - "branch": "autoland", 06:13:08 INFO - "repo_path": "integration/autoland", 06:13:08 INFO - "revision": "74516f0a4d8af50879c733489d16bdcea0bc8655", 06:13:08 INFO - "stage_platform": "macosx64", 06:13:08 INFO - "builduid": "c7cf27e69f6e4cdab6a88c4f9962c937", 06:13:08 INFO - "slavebuilddir": "test" 06:13:08 INFO - } 06:13:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 06:13:08 INFO - Running post-action listener: _resource_record_post_action 06:13:08 INFO - [mozharness: 2016-08-30 13:13:08.611023Z] Finished read-buildbot-config step (success) 06:13:08 INFO - [mozharness: 2016-08-30 13:13:08.611171Z] Running download-and-extract step. 06:13:08 INFO - Running pre-action listener: _resource_record_pre_action 06:13:08 INFO - Running main action method: download_and_extract 06:13:08 INFO - mkdir: /builds/slave/test/build/tests 06:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:08 INFO - trying https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 06:13:08 INFO - Downloading https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 06:13:09 INFO - Downloaded 1199 bytes. 06:13:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:13:09 INFO - Using the following test package requirements: 06:13:09 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:13:09 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 06:13:09 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 06:13:09 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'jsshell-mac.zip'], 06:13:09 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 06:13:09 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:13:09 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 06:13:09 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 06:13:09 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 06:13:09 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:09 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 06:13:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:09 INFO - trying https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:09 INFO - Downloading https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:10 INFO - Downloaded 16380445 bytes. 06:13:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:13:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:17 INFO - trying https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:17 INFO - Downloading https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:18 INFO - Downloaded 16380445 bytes. 06:13:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:24 INFO - trying https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:13:24 INFO - Downloading https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:13:25 INFO - Downloaded 14413998 bytes. 06:13:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 06:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:25 INFO - trying https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 06:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 06:13:28 INFO - Downloaded 111535063 bytes. 06:13:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:13:28 INFO - mkdir: /builds/slave/test/properties 06:13:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:13:28 INFO - Writing to file /builds/slave/test/properties/build_url 06:13:28 INFO - Contents: 06:13:28 INFO - build_url:https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:13:29 INFO - Running post-action listener: _resource_record_post_action 06:13:29 INFO - Running post-action listener: set_extra_try_arguments 06:13:29 INFO - [mozharness: 2016-08-30 13:13:29.387842Z] Finished download-and-extract step (success) 06:13:29 INFO - [mozharness: 2016-08-30 13:13:29.387970Z] Running populate-webroot step. 06:13:29 INFO - Running pre-action listener: _resource_record_pre_action 06:13:29 INFO - Running main action method: populate_webroot 06:13:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:13:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:13:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:13:29 INFO - '--tppagecycles', 06:13:29 INFO - '7'], 06:13:29 INFO - 'tests': ['tsvgm']}}, 06:13:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:13:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:13:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:13:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:13:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['damp', 'tps']}, 06:13:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'tests': ['damp', 'tps']}, 06:13:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['dromaeo_dom']}, 06:13:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:13:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['basic_compositor_video']}, 06:13:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:13:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['a11yr', 06:13:29 INFO - 'ts_paint', 06:13:29 INFO - 'tpaint', 06:13:29 INFO - 'sessionrestore', 06:13:29 INFO - 'sessionrestore_no_auto_restore', 06:13:29 INFO - 'tabpaint']}, 06:13:29 INFO - 'other-e10s': {'tests': ['a11yr', 06:13:29 INFO - 'ts_paint', 06:13:29 INFO - 'tpaint', 06:13:29 INFO - 'sessionrestore', 06:13:29 INFO - 'sessionrestore_no_auto_restore', 06:13:29 INFO - 'tabpaint']}, 06:13:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:13:29 INFO - 'ts_paint', 06:13:29 INFO - 'tpaint', 06:13:29 INFO - 'sessionrestore', 06:13:29 INFO - 'sessionrestore_no_auto_restore', 06:13:29 INFO - 'tabpaint']}, 06:13:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:13:29 INFO - 'ts_paint', 06:13:29 INFO - 'tpaint', 06:13:29 INFO - 'sessionrestore', 06:13:29 INFO - 'sessionrestore_no_auto_restore', 06:13:29 INFO - 'tabpaint']}, 06:13:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['a11yr', 06:13:29 INFO - 'ts_paint', 06:13:29 INFO - 'tpaint', 06:13:29 INFO - 'sessionrestore', 06:13:29 INFO - 'sessionrestore_no_auto_restore', 06:13:29 INFO - 'tabpaint']}, 06:13:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['a11yr', 06:13:29 INFO - 'ts_paint', 06:13:29 INFO - 'tpaint', 06:13:29 INFO - 'sessionrestore', 06:13:29 INFO - 'sessionrestore_no_auto_restore', 06:13:29 INFO - 'tabpaint']}, 06:13:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['tsvgx', 06:13:29 INFO - 'tsvgr_opacity', 06:13:29 INFO - 'tart', 06:13:29 INFO - 'tscrollx', 06:13:29 INFO - 'cart']}, 06:13:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:13:29 INFO - 'tsvgr_opacity', 06:13:29 INFO - 'tart', 06:13:29 INFO - 'tscrollx', 06:13:29 INFO - 'cart']}, 06:13:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'talos_options': ['--disable-e10s'], 06:13:29 INFO - 'tests': ['tp5o']}, 06:13:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'tests': ['tp5o']}, 06:13:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'talos_options': ['--disable-e10s', 06:13:29 INFO - '--xperf_path', 06:13:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:29 INFO - 'tests': ['tp5n']}, 06:13:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:29 INFO - 'talos_options': ['--xperf_path', 06:13:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:29 INFO - 'tests': ['tp5n']}}, 06:13:29 INFO - 'talos.zip': {'path': '', 06:13:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:13:29 INFO - Running post-action listener: _resource_record_post_action 06:13:29 INFO - [mozharness: 2016-08-30 13:13:29.407099Z] Finished populate-webroot step (success) 06:13:29 INFO - [mozharness: 2016-08-30 13:13:29.407207Z] Running create-virtualenv step. 06:13:29 INFO - Running pre-action listener: _resource_record_pre_action 06:13:29 INFO - Running main action method: create_virtualenv 06:13:29 INFO - Creating virtualenv /builds/slave/test/build/venv 06:13:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:13:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:13:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:13:29 INFO - Using real prefix '/tools/python27' 06:13:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:13:30 INFO - Installing distribute.............................................................................................................................................................................................done. 06:13:33 INFO - Installing pip.................done. 06:13:33 INFO - Return code: 0 06:13:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:33 INFO - 'HOME': '/Users/cltbld', 06:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:33 INFO - 'LOGNAME': 'cltbld', 06:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:33 INFO - 'MOZ_NO_REMOTE': '1', 06:13:33 INFO - 'NO_EM_RESTART': '1', 06:13:33 INFO - 'PAGER': '/bin/cat', 06:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:33 INFO - 'PWD': '/builds/slave/test', 06:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:33 INFO - 'SHELL': '/bin/bash', 06:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:33 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:33 INFO - 'USER': 'cltbld', 06:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:33 INFO - 'XPC_FLAGS': '0x0', 06:13:33 INFO - 'XPC_SERVICE_NAME': '0', 06:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:13:33 INFO - Cleaning up... 06:13:33 INFO - Return code: 0 06:13:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:33 INFO - 'HOME': '/Users/cltbld', 06:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:33 INFO - 'LOGNAME': 'cltbld', 06:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:33 INFO - 'MOZ_NO_REMOTE': '1', 06:13:33 INFO - 'NO_EM_RESTART': '1', 06:13:33 INFO - 'PAGER': '/bin/cat', 06:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:33 INFO - 'PWD': '/builds/slave/test', 06:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:33 INFO - 'SHELL': '/bin/bash', 06:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:33 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:33 INFO - 'USER': 'cltbld', 06:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:33 INFO - 'XPC_FLAGS': '0x0', 06:13:33 INFO - 'XPC_SERVICE_NAME': '0', 06:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:33 INFO - Downloading/unpacking psutil>=3.1.1 06:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:13:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:36 INFO - Installing collected packages: psutil 06:13:36 INFO - Running setup.py install for psutil 06:13:37 INFO - building 'psutil._psutil_osx' extension 06:13:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:13:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:13:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:13:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:13:37 INFO - building 'psutil._psutil_posix' extension 06:13:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:13:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:13:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:13:37 INFO - ^ 06:13:37 INFO - 1 warning generated. 06:13:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:13:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:38 INFO - Successfully installed psutil 06:13:38 INFO - Cleaning up... 06:13:38 INFO - Return code: 0 06:13:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:13:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:38 INFO - 'HOME': '/Users/cltbld', 06:13:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:38 INFO - 'LOGNAME': 'cltbld', 06:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:38 INFO - 'MOZ_NO_REMOTE': '1', 06:13:38 INFO - 'NO_EM_RESTART': '1', 06:13:38 INFO - 'PAGER': '/bin/cat', 06:13:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:38 INFO - 'PWD': '/builds/slave/test', 06:13:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:38 INFO - 'SHELL': '/bin/bash', 06:13:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:38 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:38 INFO - 'USER': 'cltbld', 06:13:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:38 INFO - 'XPC_FLAGS': '0x0', 06:13:38 INFO - 'XPC_SERVICE_NAME': '0', 06:13:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:13:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:13:40 INFO - Installing collected packages: mozsystemmonitor 06:13:40 INFO - Running setup.py install for mozsystemmonitor 06:13:41 INFO - Successfully installed mozsystemmonitor 06:13:41 INFO - Cleaning up... 06:13:41 INFO - Return code: 0 06:13:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:41 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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:13:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:41 INFO - 'HOME': '/Users/cltbld', 06:13:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:41 INFO - 'LOGNAME': 'cltbld', 06:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:41 INFO - 'MOZ_NO_REMOTE': '1', 06:13:41 INFO - 'NO_EM_RESTART': '1', 06:13:41 INFO - 'PAGER': '/bin/cat', 06:13:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:41 INFO - 'PWD': '/builds/slave/test', 06:13:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:41 INFO - 'SHELL': '/bin/bash', 06:13:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:41 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:41 INFO - 'USER': 'cltbld', 06:13:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:41 INFO - 'XPC_FLAGS': '0x0', 06:13:41 INFO - 'XPC_SERVICE_NAME': '0', 06:13:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:41 INFO - Downloading/unpacking jsonschema==2.5.1 06:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:13:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:13:44 INFO - warning: no files found matching '*.txt' 06:13:44 INFO - no previously-included directories found matching 'build' 06:13:44 INFO - no previously-included directories found matching 'dist' 06:13:44 INFO - no previously-included directories found matching '.git*' 06:13:44 INFO - Installing collected packages: jsonschema, functools32 06:13:44 INFO - Running setup.py install for functools32 06:13:44 INFO - warning: no files found matching '*.txt' 06:13:44 INFO - no previously-included directories found matching 'build' 06:13:44 INFO - no previously-included directories found matching 'dist' 06:13:44 INFO - no previously-included directories found matching '.git*' 06:13:44 INFO - Successfully installed jsonschema functools32 06:13:44 INFO - Cleaning up... 06:13:44 INFO - Return code: 0 06:13:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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', '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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:13: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 functools32==3.2.3-2 06:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:44 INFO - 'HOME': '/Users/cltbld', 06:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:44 INFO - 'LOGNAME': 'cltbld', 06:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:44 INFO - 'MOZ_NO_REMOTE': '1', 06:13:44 INFO - 'NO_EM_RESTART': '1', 06:13:44 INFO - 'PAGER': '/bin/cat', 06:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:44 INFO - 'PWD': '/builds/slave/test', 06:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:44 INFO - 'SHELL': '/bin/bash', 06:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:44 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:44 INFO - 'USER': 'cltbld', 06:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:44 INFO - 'XPC_FLAGS': '0x0', 06:13:44 INFO - 'XPC_SERVICE_NAME': '0', 06:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:13:44 INFO - Cleaning up... 06:13:44 INFO - Return code: 0 06:13:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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', '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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:13: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 blobuploader==1.2.4 06:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:44 INFO - 'HOME': '/Users/cltbld', 06:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:44 INFO - 'LOGNAME': 'cltbld', 06:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:44 INFO - 'MOZ_NO_REMOTE': '1', 06:13:44 INFO - 'NO_EM_RESTART': '1', 06:13:44 INFO - 'PAGER': '/bin/cat', 06:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:44 INFO - 'PWD': '/builds/slave/test', 06:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:44 INFO - 'SHELL': '/bin/bash', 06:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:44 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:44 INFO - 'USER': 'cltbld', 06:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:44 INFO - 'XPC_FLAGS': '0x0', 06:13:44 INFO - 'XPC_SERVICE_NAME': '0', 06:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:13:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:13:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:48 INFO - Downloading docopt-0.6.1.tar.gz 06:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:13:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:13:48 INFO - Running setup.py install for blobuploader 06:13:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:13:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:13:49 INFO - Running setup.py install for requests 06:13:49 INFO - Running setup.py install for docopt 06:13:49 INFO - Successfully installed blobuploader requests docopt 06:13:49 INFO - Cleaning up... 06:13:49 INFO - Return code: 0 06:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:49 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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:13:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:49 INFO - 'HOME': '/Users/cltbld', 06:13:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:49 INFO - 'LOGNAME': 'cltbld', 06:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:49 INFO - 'MOZ_NO_REMOTE': '1', 06:13:49 INFO - 'NO_EM_RESTART': '1', 06:13:49 INFO - 'PAGER': '/bin/cat', 06:13:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:49 INFO - 'PWD': '/builds/slave/test', 06:13:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:49 INFO - 'SHELL': '/bin/bash', 06:13:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:49 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:49 INFO - 'USER': 'cltbld', 06:13:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:49 INFO - 'XPC_FLAGS': '0x0', 06:13:49 INFO - 'XPC_SERVICE_NAME': '0', 06:13:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-qvWOrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-1zxubl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-5OZcHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-KiKVAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-4UKQkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-x660Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-PBaf65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-oQHgd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-IVJUEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:13:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-PaGKsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:13:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-n6bP8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:13:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-PVfRQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:13:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ZWOjbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:13:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-9Ma0yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-yulZcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:13:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-xtBO_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:13:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-F39sJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:13:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:13:51 INFO - Running setup.py install for manifestparser 06:13:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:13:51 INFO - Running setup.py install for mozcrash 06:13:52 INFO - Running setup.py install for mozdebug 06:13:52 INFO - Running setup.py install for mozdevice 06:13:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Running setup.py install for mozfile 06:13:52 INFO - Running setup.py install for mozhttpd 06:13:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Running setup.py install for mozinfo 06:13:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Running setup.py install for mozInstall 06:13:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:13:52 INFO - Running setup.py install for mozleak 06:13:53 INFO - Running setup.py install for mozlog 06:13:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:13:53 INFO - Running setup.py install for moznetwork 06:13:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:13:53 INFO - Running setup.py install for mozprocess 06:13:53 INFO - Running setup.py install for mozprofile 06:13:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:13:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:13:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:13:53 INFO - Running setup.py install for mozrunner 06:13:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:13:53 INFO - Running setup.py install for mozscreenshot 06:13:54 INFO - Running setup.py install for moztest 06:13:54 INFO - Running setup.py install for mozversion 06:13:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:13:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:13:54 INFO - Cleaning up... 06:13:54 INFO - Return code: 0 06:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:54 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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:54 INFO - 'HOME': '/Users/cltbld', 06:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:54 INFO - 'LOGNAME': 'cltbld', 06:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:54 INFO - 'MOZ_NO_REMOTE': '1', 06:13:54 INFO - 'NO_EM_RESTART': '1', 06:13:54 INFO - 'PAGER': '/bin/cat', 06:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:54 INFO - 'PWD': '/builds/slave/test', 06:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:54 INFO - 'SHELL': '/bin/bash', 06:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:54 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:54 INFO - 'USER': 'cltbld', 06:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:54 INFO - 'XPC_FLAGS': '0x0', 06:13:54 INFO - 'XPC_SERVICE_NAME': '0', 06:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:13:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-4pl9Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:13:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-yeiKJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:13:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-6lhSoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:13:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-_PY4cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-gbY0Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-kSsse9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-lpfZWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ZSvMjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-rdVfQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-lWXwjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-6mvSAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-5v8wOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:13:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-9S0gsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:13:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-pTry_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-OJIycO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:13:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-iAoW2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:13:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-QHNJfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:13:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:13: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 06:13: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 06:13: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 06:13: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 06:13: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 06:13: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 06:13:58 INFO - Downloading blessings-1.6.tar.gz 06:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:13:59 INFO - Installing collected packages: blessings 06:13:59 INFO - Running setup.py install for blessings 06:13:59 INFO - Successfully installed blessings 06:13:59 INFO - Cleaning up... 06:13:59 INFO - Return code: 0 06:13:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:13:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:13:59 INFO - Reading from file tmpfile_stdout 06:13:59 INFO - Current package versions: 06:13:59 INFO - blessings == 1.6 06:13:59 INFO - blobuploader == 1.2.4 06:13:59 INFO - docopt == 0.6.1 06:13:59 INFO - functools32 == 3.2.3-2 06:13:59 INFO - jsonschema == 2.5.1 06:13:59 INFO - manifestparser == 1.1 06:13:59 INFO - mozInstall == 1.12 06:13:59 INFO - mozcrash == 0.17 06:13:59 INFO - mozdebug == 0.1 06:13:59 INFO - mozdevice == 0.48 06:13:59 INFO - mozfile == 1.2 06:13:59 INFO - mozhttpd == 0.7 06:13:59 INFO - mozinfo == 0.9 06:13:59 INFO - mozleak == 0.1 06:13:59 INFO - mozlog == 3.3 06:13:59 INFO - moznetwork == 0.27 06:13:59 INFO - mozprocess == 0.23 06:13:59 INFO - mozprofile == 0.28 06:13:59 INFO - mozrunner == 6.12 06:13:59 INFO - mozscreenshot == 0.1 06:13:59 INFO - mozsystemmonitor == 0.3 06:13:59 INFO - moztest == 0.7 06:13:59 INFO - mozversion == 1.4 06:13:59 INFO - psutil == 3.1.1 06:13:59 INFO - requests == 1.2.3 06:13:59 INFO - wsgiref == 0.1.2 06:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:59 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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:59 INFO - 'HOME': '/Users/cltbld', 06:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:59 INFO - 'LOGNAME': 'cltbld', 06:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:59 INFO - 'MOZ_NO_REMOTE': '1', 06:13:59 INFO - 'NO_EM_RESTART': '1', 06:13:59 INFO - 'PAGER': '/bin/cat', 06:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:59 INFO - 'PWD': '/builds/slave/test', 06:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:59 INFO - 'SHELL': '/bin/bash', 06:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:59 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:59 INFO - 'USER': 'cltbld', 06:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:59 INFO - 'XPC_FLAGS': '0x0', 06:13:59 INFO - 'XPC_SERVICE_NAME': '0', 06:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:13:59 INFO - Cleaning up... 06:13:59 INFO - Return code: 0 06:13:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:59 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 0x10f80fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d857bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, '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.n0ljApupab/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.OZSBOKmjXg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:59 INFO - 'HOME': '/Users/cltbld', 06:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:59 INFO - 'LOGNAME': 'cltbld', 06:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:59 INFO - 'MOZ_NO_REMOTE': '1', 06:13:59 INFO - 'NO_EM_RESTART': '1', 06:13:59 INFO - 'PAGER': '/bin/cat', 06:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:59 INFO - 'PWD': '/builds/slave/test', 06:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:59 INFO - 'SHELL': '/bin/bash', 06:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:13:59 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:59 INFO - 'USER': 'cltbld', 06:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:59 INFO - 'XPC_FLAGS': '0x0', 06:13:59 INFO - 'XPC_SERVICE_NAME': '0', 06:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:00 INFO - Cleaning up... 06:14:00 INFO - Return code: 0 06:14:00 INFO - Running post-action listener: _resource_record_post_action 06:14:00 INFO - Running post-action listener: _start_resource_monitoring 06:14:00 INFO - Starting resource monitoring. 06:14:00 INFO - [mozharness: 2016-08-30 13:14:00.099741Z] Finished create-virtualenv step (success) 06:14:00 INFO - [mozharness: 2016-08-30 13:14:00.100541Z] Running install step. 06:14:00 INFO - Running pre-action listener: _resource_record_pre_action 06:14:00 INFO - Running main action method: install 06:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:00 INFO - Reading from file tmpfile_stdout 06:14:00 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:00 INFO - Reading from file tmpfile_stdout 06:14:00 INFO - Output received: 06:14:00 INFO - Usage: mozinstall [options] installer 06:14:00 INFO - Options: 06:14:00 INFO - -h, --help show this help message and exit 06:14:00 INFO - -d DEST, --destination=DEST 06:14:00 INFO - Directory to install application into. [default: 06:14:00 INFO - "/builds/slave/test"] 06:14:00 INFO - --app=APP Application being installed. [default: firefox] 06:14:00 INFO - mkdir: /builds/slave/test/build/application 06:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:14:34 INFO - Reading from file tmpfile_stdout 06:14:34 INFO - Output received: 06:14:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:14:34 INFO - Running post-action listener: _resource_record_post_action 06:14:34 INFO - [mozharness: 2016-08-30 13:14:34.547885Z] Finished install step (success) 06:14:34 INFO - [mozharness: 2016-08-30 13:14:34.548023Z] Running run-tests step. 06:14:34 INFO - Running pre-action listener: _resource_record_pre_action 06:14:34 INFO - Running main action method: run_tests 06:14:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:34 INFO - 2016-08-30 06:14:34.562 screenresolution[1636:7383] starting screenresolution argv=screenresolution get 06:14:34 INFO - 2016-08-30 06:14:34.565 screenresolution[1636:7383] Display 0: 1600x1200x32@60 06:14:34 INFO - 2016-08-30 06:14:34.571 screenresolution[1637:7385] starting screenresolution argv=screenresolution list 06:14:34 INFO - Available Modes on Display 0 06:14:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:34 INFO - Intel Iris: 06:14:34 INFO - Chipset Model: Intel Iris 06:14:34 INFO - Type: GPU 06:14:34 INFO - Bus: Built-In 06:14:34 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:34 INFO - Vendor: Intel (0x8086) 06:14:34 INFO - Device ID: 0x0a2e 06:14:34 INFO - Revision ID: 0x0009 06:14:34 INFO - Displays: 06:14:34 INFO - Display: 06:14:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:34 INFO - Display Serial Number: 1600x1200 60 06:14:34 INFO - Main Display: Yes 06:14:34 INFO - Mirror: Off 06:14:34 INFO - Online: Yes 06:14:34 INFO - Rotation: Supported 06:14:34 INFO - Return code: 0 06:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:14:34 INFO - Python 2.7.3 06:14:34 INFO - Return code: 0 06:14:34 INFO - grabbing minidump binary from tooltool 06:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:34 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 0x10f773d30>, '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 0x10f4d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f76bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:14:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:14:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:14:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:14:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:14:34 INFO - Return code: 0 06:14:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:14:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:14:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:14:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:14:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:14:34 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/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:14:34 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/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0303 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n0ljApupab/Render', 06:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:34 INFO - 'HOME': '/Users/cltbld', 06:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:34 INFO - 'LOGNAME': 'cltbld', 06:14:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:14:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:34 INFO - 'MOZ_NO_REMOTE': '1', 06:14:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:14:34 INFO - 'NO_EM_RESTART': '1', 06:14:34 INFO - 'PAGER': '/bin/cat', 06:14:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:34 INFO - 'PWD': '/builds/slave/test', 06:14:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:34 INFO - 'SHELL': '/bin/bash', 06:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZSBOKmjXg/Listeners', 06:14:34 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 06:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:34 INFO - 'USER': 'cltbld', 06:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:34 INFO - 'XPC_FLAGS': '0x0', 06:14:34 INFO - 'XPC_SERVICE_NAME': '0', 06:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:34 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/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:14:35 INFO - mozversion application_buildid: 20160830043321 06:14:35 INFO - mozversion application_changeset: 74516f0a4d8af50879c733489d16bdcea0bc8655 06:14:35 INFO - mozversion application_display_name: Nightly 06:14:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:14:35 INFO - mozversion application_name: Firefox 06:14:35 INFO - mozversion application_remotingname: firefox 06:14:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:14:35 INFO - mozversion application_vendor: Mozilla 06:14:35 INFO - mozversion application_version: 51.0a1 06:14:35 INFO - mozversion platform_buildid: 20160830043321 06:14:35 INFO - mozversion platform_changeset: 74516f0a4d8af50879c733489d16bdcea0bc8655 06:14:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:14:35 INFO - mozversion platform_version: 51.0a1 06:14:35 INFO - using testdate: 1472562875 06:14:35 INFO - actual date: 1472562875 06:14:35 INFO - starting webserver on 'localhost:49275' 06:14:35 INFO - SUITE-START | Running 2 tests 06:14:35 INFO - TEST-START | dromaeo_css 06:14:35 INFO - operating with platform_type : mac_ 06:14:35 INFO - Initialising browser for dromaeo_css test... 06:14:35 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmprcMLeH/profile http://localhost:49275/getInfo.html) 06:14:37 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 06:14:37 INFO - PROCESS | 1647 | colorDepth:24 06:14:37 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 06:14:37 INFO - PROCESS | 1647 | __metrics 06:14:38 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 06:14:38 INFO - TEST-INFO | 1647: exit 0 06:14:38 INFO - Browser initialized. 06:14:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:14:38 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmprcMLeH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:50 INFO - PROCESS | 1650 | RSS: Main: 244219904 06:14:50 INFO - PROCESS | 1650 | 06:15:40 INFO - PROCESS | 1650 | 1472562940364 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:17:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:17:53 INFO - PROCESS | 1650 | RSS: Main: 264683520 06:17:53 INFO - PROCESS | 1650 | 06:20:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:20:56 INFO - PROCESS | 1650 | RSS: Main: 275410944 06:20:56 INFO - PROCESS | 1650 | 06:23:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:23:59 INFO - PROCESS | 1650 | RSS: Main: 275972096 06:23:59 INFO - PROCESS | 1650 | 06:27:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:27:01 INFO - PROCESS | 1650 | RSS: Main: 270204928 06:27:01 INFO - PROCESS | 1650 | 06:30:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:30:05 INFO - PROCESS | 1650 | RSS: Main: 275587072 06:30:05 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:33:08 INFO - PROCESS | 1650 | RSS: Main: 278171648 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | __start_tp_report 06:33:08 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 06:33:08 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 06:33:08 INFO - PROCESS | 1650 | |i|pagename|runs| 06:33:08 INFO - PROCESS | 1650 | |0;dojo.html;3375.5949286085665;3404.3021180657965;3428.948565771513;3436.879709210175;3442.896713098608;5684.630499017561;5691.772329106836;5766.2215600893815;5791.333996590393;5798.507126894214;5740.741666625001;5754.251947246862;5771.365149833515;5810.012297909355;5817.650940943547;5172.534471897528;5301.7084060376665;5303.522682958533;5384.892302153955;5407.270018547505;4479.888002799939;4621.821435533934;4847.684900481458;5092.312537807404;5462.071447853875;4493.943923178051;5168.095583272912;5179.689218646856;5193.558547523465;5281.155015197569;5214.400343960455;5241.24002019705;5243.580513558906;5250.291210686547;5303.575713942875;5274.525292723673;5287.312649355597;5288;5291.86770330741;5308.044551980642;5693.516051135658;5709.172170035363;5777.133429985493;5795.507381872546;5873.2658417697785;5386.434424385422;6099.207103076572;6222.782202622887;6290.528210384239;6300.936990630081;6270.529710271702;6326.841828954267;6330.620162790247;6333.334999824998;6360.650164240965;5735.254416925814;5794.362620111784;5806.187133801272;5816.47651711348;5848.795292164839;5289.656172348785;6258.123862659231;6264.154339164154;6273.435390814849;6273.749050038039;6179.81460556184;6193.504519638418;6193.876122477525;6194.9690251549355;6206.286277078194;6073.453389194994;6157.8460538486;6250.812475625738;6263.686815659199;6291.6854157291955;5100.948990510047;6216.720247588869;6249.531285153632;6271.122042913996;6315.305316415191;6220.844478888064;6250.656213908279;6273.372662733781;6295.181626388632;6307.4954003679595;4824.179889418807;4909.68087074339;4926;4963.553280204799;5003.9241563064115;4409.404730361424;4461.687681862303;4464.955350446519;4486.730796152176;4520.88697782558;5709.286339207599;5806.593538452352;5808.709564521757;5845.743165219498;5853.180554722342;6153.7384836108495;6224.595401298901;6270.372962703785;6289.339619339995;6298.212723409574;5811.099279611667;5840.328362238312;5843.941560584425;5877.294724633071;5891.351951285355;5436.836894893159;5449.782008719686;5463.4263402342185;5473.17902314656;5490.835274941758;6223.159873417031;6235.688215589294;6246.094316324198;6291.056341548713;6331.905021424683;5755.395683453177;5869.002269614261;6275.717592708248;6342.936570634234;6344.682765861596;6255.24937007562;6297.307296197323;6332.271788744353;6342.207224096988;6347.619142851444;6097.969510152421;6161.907571386343;6185.226846644169;6212.254529456313;6231.22109736283;6256.593321434092;6266.592671476339;6277.497800176066;6278.717457714505;6350.7777227796805;6208.068789681584;6210.347913469021;6219.657918814509;6245.8757423662355;6259.436650701458;6109.495762817132;6143.109249158936;6154.723037463235;6197.442230199304;6233.719482623203;5416.835380393234;5604.523615492566;6095.695215239309;6118.265808103056;6143.477804386677;6203.286622038343;6219.036049412348;6255.374462553708;6260.28006779208;6263.96868015657;5842.853928651818;6019.789307374221;6038.184845045863;6098.451139397298;6108.144859719554 06:33:08 INFO - PROCESS | 1650 | |1;ext.html;499.26256626938255;506.4125614287427;513.524989384819;515.5257163409665;564.134054226762;32274.515882261756;34248.48627270593;40335.19329613406;40353;40387.79806100969;37258.8137059315;40758;40970.38544421836;41030.38454423178;41145.79427102868;9679.467629280387;9899.851502227473;9903.207743380512;9909.157721593638;9910.256730745186;9761.707148785512;9865.112139907444;9865.90134098657;9878.962708915567;9899.059589339002;9822.116009559139;9862.753431164207;9866.013398660149;9919.652812151577;9960.452175130366;9863.112319891208;9879.407235565888;9883.703488895344;9886.456244906527;9903.405795652248;9786.510674466248;9864.457454839981;9868.60525578976;9870.753231169207;9895.257855660782;38182.618173818184;38888.44446222148;39065.41401878974;39135.21729565393;39338.60661393378;3259.8044117353033;3266.487903647063;3295.307985323085;3422.4866270059442;3604.945925811115;24520.509589808105;30246.69753302461;30470;30945;31098;2661.574148136289;3211.1811488070625;3218.4850423932057;3226.2257058306072;3353.6814002669707;502814;507449;507918.99999999633;509009.9099009;509773;56160.71919640457;56445.71777141088;56500.43499564952;56519.71740141355;56654.716726416926;31017.689823101933;31726.841365793483;31842.681573184436;59393.40606593879;59439;15274.847251527342;15368;15495.380184792482;15543.222838858012;15599.688006239812;11741.06071514294;11851.88148118525;11860.644180674593;11873.643790686294;11895.88104118965;18674.813251867577;18685.972271525196;18856.642919635047;18905.527361816065;18948.336808211647;7631.54210747357;7763.029621297338;7770.805729856799;7805.41459390548;7834.451588388758;728.9271072892774;857.7169534053747;980.3872579637726;1011.3628414099071;1022.823752684404;29501.704982950327;29561.55657665137;29853.253668658024;30314.84842575773;30489.932852350063;1033.03927347566;1047.8690163729534;1056.7675111475462;1104.939228342433;1126.9887301127048;13401.329933503286;14954.850451495564;15001.624959375884;15202.46791362297;15486.303116359792;542359.2882035644;697344;698663;700210;700542;55894.16158757622;55932;56199;56348.71825640927;56553;1120.8318752187238;1340.4169186403944;1358.77580199266;1363.5023216525897;1366.5148872150244;27916.58125128084;29241.268968275963;29411.411771764873;29777.85111074431;30246.54630180505;47166.52833471759;47511.287330689374;47716;47737.76131119322;47884.5211547894;590484;590667;593782;594117;597409;25875.22374328773;26071.60892586575;26110.34724131912;26143.215703528924;26196.86901565556;44950.1009979792;45524.77237613791;46653.76673116613;46711;47253.2912006327;38142.61857381391;38181.80909095437;38372;38750.89354001864;39680.801595991834;37495.812520938314;37810.054748631504;37909.81045094757;38956.61043389643;39033.609663904135;27532.449351012467;37168;37522.06194845041;38050.80974595109;39879.40180897231;30778.846105769328;33580.83209583937;33818;33903.98288051363;34007.82996085004;24758.25725228246;25223.495530088927;25403.110891118722;25528.489430211663;25671.74328256768 06:33:08 INFO - PROCESS | 1650 | |2;jquery.html;311.98752049918005;322.37459328901946;365.2421225956141;378.98484060637577;395.00064835965003;19103.904480477595;19414.514637134078;20820.791792082076;20993.160273589037;21089.57820843586;19691.212351505957;19998.400047998548;20613.07241174147;20751.584968300624;20908.16367345308;5926.318473375563;6018.548608854331;6074.179985701918;6151.077338399254;6168.414000669952;5858;5966.642001479903;6018.939810601903;6037.154798328237;6068.059450785136;5515.834524964257;5810.6513609183585;5998.55010874184;6004.129401236818;6015;5765.365809760923;5848.736806843703;5868.618539794899;5874.9118763218585;5901.114832775075;5636.4927156556105;5766.826995190151;5790.160426738099;5798.362180160179;5825.067989121762;12776.488940442372;12986.935065324707;13141.211527308296;13152.473901044043;13204.273764942924;2239.5185035217505;2375.0873558318995;2442.6091825308044;2861;2975.598294230273;10061.346012509164;10072.244581656405;10388.844167337496;12669.113162078658;14943.925280373638;1474.793528905954;1843.0968825275652;1850.5466160790693;1861.450871992752;1903.1530968718926;107042;127748.7225127746;128542.3572882139;128902.62132961328;129155;9090.636374545076;9277.443353398818;11095.1123910087;11200.831987520194;11266.042386397085;11793.469293881624;12109.970652494636;13648.454061837416;14065;14285.357158927873;6731.663416829139;6772.525923185428;7988.920110798817;8142.552159631158;8227.670893164206;7888.526688398714;7891.881621775678;7906.881396779053;8055.516668999879;8055.972013993003;3941.7437866538585;4271.188474189894;4311.137772445523;4484.148011877733;4528.977355113203;1799.9550011249823;1928.7685477742762;1931.758530183727;1943.8736482128616;1945.5914258005694;837.3468694418364;906.3066753933247;911.382296423853;952.9190018848476;984.9950750246203;19775.901120494305;19897.801021989886;20461.283855065;20524.07641656129;20721.067551960197;867.137198487509;870.6082262981557;936.9016253293443;942.4910548303976;946.3375637053952;10402.687919362432;10882.23824332305;10909.39998300101;10913.454327283764;10924.453777311102;537305;549024;568997.7051262137;590644;591347;104757.47621261998;106531;124508.94620280009;128091;131906.68093319135;823.5017814222429;955.2310390136007;997.7405874472689;998.1715176403568;1032.5921261101823;18188.909055455166;18666.066696665384;18977.620447591245;19093.713594296376;19584.706229406856;54315.72842135922;54872;55499;56144;56628.433715662315;74091;75841.6207918957;80186;80229.59885200537;81344.18655813366;7822.921770782219;7848.725294614661;8006.799830004296;8015.599220039091;8075.273225409741;10781.299215550964;12316.445759941003;12668.072897401835;12717.682057948625;12753.681157971125;10728.570857165625;10784.083352914777;10930.234883558074;11043.061339785887;11188.440577970907;9917.603295868084;10123.696289111338;10451.68644940653;10535.894641053797;11083.334999900031;10933.507992140532;11249.268797528135;11249.718757030812;11379.43102844871;11452.599159029394;6401.551891367746;7721.884171737541;7811.843763124592;7923.7226697065325;8145.714899978472;9874;10544.472776360997;10850.837237441287;11095.445227738419;11117.888821111685 06:33:08 INFO - PROCESS | 1650 | |3;mootools.html;1412.545078569074;1500.2198856594575;1646.7118254305494;1701.2089378439023;1871.6724573199688;7852.37181025518;8472.957635211824;8485.575721213945;8904.020557738651;8913.108689131092;8683.044865064838;8760.255378292853;8770.956145219265;8781.824363512726;8783.868241976375;2357.5402796454655;2375.287413775869;2376.702912135983;2379.2505360811374;2381.202297230421;2264.6036943534896;2292.713410823647;2309.9884500577473;2311.9653205201935;2313.3175713164655;2348.3072493614427;2351.6472529120683;2353.1411034972284;2377.3581133094053;2379.0127097254617;2335.6613291072867;2337.614293641547;2343.8359314847967;2349.283468542094;2355.9411014724596;2334.498082912182;2345.7419683834764;2348.213348528228;2348.2720356689483;2350.2714158610884;8703.608337624759;8774.561271936378;8819.691310804155;8827.602757875911;8849.336299777542;4447.977760111211;4576.725396476222;4769.689970151929;5065.822696205615;5083.364579427572;2949.8525073746227;3101.7673674474504;3171.349873275973;3249.6587858275016;3548.520949671787;979.8291042204569;1027.7482016905906;1031.1338475680463;1097.1497089755424;1121.775644871029;10799.514021868956;10845.240833141683;10912.181586381053;10923.344599324066;10939.398333091598;4123.876283711494;4543.136804007228;4680.836170734008;4691.413573303337;4717.174494463455;8466.64533674609;8752.256058234994;9308.581113849894;9342.48616326095;9376.437413755197;5089.898202036013;5168.457311982188;5170.276161337416;5177.171652535576;5182.300389447451;4363.5418281080665;4704.88237794051;4764.166270902579;4830.082284365959;4836.806527738851;3859.4017927221325;3876.5541962674088;3964.28642844285;3971.5631280559114;3982.561918188997;1275.4770544077069;1281.128832393981;1291.3607764156802;1293.4632127666912;1293.734784369202;848.2577744473585;850.2050582705191;911.8632205169145;912.5118061837018;927.7521733268743;5294.232336311214;5620.4660557247;5861;5931.902598019294;5981.641101533922;913.5249670171473;934.6588495199339;937.9906200937903;943.5235206220815;954.5227386306847;3462.221000274918;3790.8673196438544;3857.9421308680394;3946.940795888064;4046.858359957387;10333.173346132291;10629.9468502657;10640.574377024832;10641.255112142231;10644.574217031231;10544.945505449547;10620.203484738675;10626.309289896286;10642.946785266024;10654.627088052035;7695.961520192363;8051.194880511902;8124.512529248264;8141.43009989295;8144.470609410369;5777.768889244383;5929.85175370602;5970.5223582114195;6064.3935606439;6113.144159817718;9543.28425368114;9706.174975127193;9776.608935642778;9850.802983940424;9997.300188986992;9691.515424228619;9753.561089750836;9979.301448898797;10021.298509104292;10132.088112069949;6864.897026544506;7213.783586492414;7363.300486453778;7391.928170415152;7535;8197.754067377988;8266.875996860172;8271.83456330858;8278;8301.709440169565;7221.67502462401;7383.261673832574;7401.740939067106;7458;7475.36459400957;7009.12385951756;7181.533200341961;7228.168760592599;7233.565986040854;7235.457340699363;6816.079829223189;6875.1749790025515;6941.687624057031;6941.895871562032;6959.965200173967;4680.672352935262;4863.294822250683;4889.511048895224;4917.729524876167;4988.276699878425;4779.5220477951925;4800.543948324904;4864.464908860094;4940.061388336205;4976.457298237558 06:33:08 INFO - PROCESS | 1650 | |4;prototype.html;301.03218153636067;307.22425874666465;312.99843500782487;314.05939212059883;318.5699305936984;4424.446944131983;4818.711346901257;4885.828995985141;4961.801527938883;5207.427183009866;4677.976610116944;5338.813141540047;5389.461053894618;5671.376148623658;5674.773009079642;3538.274653695999;3606.6032736398975;4028.4561584186054;4201.600847919451;4282.978585107086;3555.5022296878456;3992.800359982004;4026.6979976501734;4203.327467605184;4258.701890867641;3715.4580848947653;3842.884713458601;3930.6855451563806;4159.043420013399;4212.431321771553;3520.77114987525;4074.7962601870086;4173.520045194811;4181.477315335583;4196.81114349855;3660.5790334111653;3680.411134218539;3692.372296709566;3701.4632878232505;3707.4994875691705;5222.059298655489;5240.81657142002;5289.360298307537;5336;5379.488948549882;4826.951730482685;4834.2203233140735;4856.902861942776;4871.853844384638;4891.0951473977075;4916.434610019858;4961.677490963076;5192.416313024526;5882.646991192007;5927.347991720907;3229.7577681673733;3574.1771696434744;3849.4225866120028;3858.4791053207737;3873.573906870242;5409.675419474844;5865.882682346414;6055.910710804766;6074.66357401371;6128.7242074106325;3932.4297976793205;3946.973786815449;3953.545342285674;3987.7806720630065;4007.7996100194873;3340.3319336132386;3853.2871418787613;3979.582143874851;3993.221321842213;4011.859584914514;4136.834526618962;4683.391159149289;4757.548947571024;4763.54746299101;4772.164871147535;4892.730899800546;5884.264466941632;5894.200254878898;5934.228550288435;5954.791582294599;1164.3596022187762;1218.6587755428495;1343.9126456780277;1361.4213959067554;1365.6858922447893;804.3364224514798;821.7904434369317;829.4572095901618;835.6364981233183;837.5770236030766;3751.606081361472;4108.712390132662;4544.954550454519;4611.79246933882;4633.675642704979;4568.565986231302;5010.592796898144;5078.568321692624;5112.488751124858;5144.768485418165;4566.931496027562;4595.080983803253;4621.197732884178;4651.790669419885;4671.27595222741;2434.062885788984;2454.779069883719;2661.574148136289;2707.7796207110373;2712.7151649076563;4367.868963931087;4824.734639594786;5027.899442011212;5164.870878227999;5275.419703832576;4409.2724700424715;4765.976170119127;5139.383274007143;5169.061601899288;5232.712200828991;5569.860753481195;6045.939540604538;6180.505559555225;6297.27581328144;6327.272363678144;6004.849878753066;6084.908726369196;6094.695265236632;6117.388261173847;6122.938770612237;5806.712575717447;5970.58205925581;5995.2206213192;6039.909401358896;6056.273247210363;6226.25284965807;6251.937480625317;6272.905906411316;6284.517615541927;6336.651484168415;3361.781484203519;3953;3967.7420967637013;3972.423998520256;4000.699947504007;5788.160716695971;6022.307434644897;6054.66699331541;6058.969705151446;6174.579846635209;5433.864153396196;5544.584156188383;5665.263515742927;5698.1737648041635;5765.4522820332;4396.27461468854;5111.667741596784;5759.0209664358;5835.708214589338;5855.945929732518;5333.493318134771;5640.756564975074;5687.232223649919;5708.514776244066;5747.453991870766;5309.38942021657;5832.679202643895;5924;5947.888499582586;6029.643330250834;4677.462091859344;5066.898662026812;5243.344581927259;5527.2538207343105;5781.306243250837 06:33:08 INFO - PROCESS | 1650 | |5;yui.html;635.2059925093633;638.3488841381787;700.1458220970414;737.1449119021936;802.4743792815705;15235.390584376626;16387.344506219735;16388.016718996867;16407.261673224704;16424.91787541062;14909.776353354708;15002.774958375632;15010.399584016626;15042.323095460702;15319.69360612787;683.2893790457917;842.8946381702287;847.5635047950295;853.5945425922699;871.7733389318792;855.6064210463195;857.4640849469082;860.0968982568278;861.1775754154799;863.7624653220352;908.3505293714992;917.7980844214262;919.4391421233042;919.6643225222779;921.4010892919589;876.9736907892774;883.1301168349203;907.2560500389683;911.4759013567159;916.2715641065336;674.9932500674979;682.6313790553095;683.5830143612393;684.2165720250285;686.9553479023848;14956.925215373962;14973;14997.925010374987;15005.474808381763;15015.174165420898;14316.141031538142;14341.42634294627;14353.425862965469;14357.353919073666;14556.417743290256;11878.287302761863;11967.975129409759;12101.152919295564;12234.81647775284;12455.314957677325;3750.324941510527;3760.435934609803;3899.083715326896;3924;3932.980335098306;119297;119441.80558194393;120280;120346;124922.37538812339;10751.354918704903;10850.240483166102;10929.672109836718;11085.722856928642;11547;22775.430614234447;22782.886085569797;22812.65781013286;22833.543329133325;22839.429014274443;7509.849803003909;7803.7268695595385;7811.218878112143;7828.099768526692;8037.477563958324;4358.5205627380965;4425.22558552252;4488.304312831517;4539.75031373271;4626.74552899587;3312.337532493511;3428.400029994741;3528.4883691864534;3625.4199328107375;3670.9632903671154;665.9933400666029;677.6205325018005;683.5386114372778;700.2507317170579;702.9859402811915;593.8841925824423;659.423004870738;659.8086554899025;665.6571865489277;669.6049330894796;9007.813357548512;9292.16370526656;9371.953140234391;9372.62509499626;9547.761305967406;642.8521440068811;662.6653539962289;672.4788289075907;674.4536925090692;682.9112215411965;4400.625946794558;4626.814927402934;4630.513796051433;4701.694389864648;4712.081144176853;86854;114632.42683786528;130896;161677;168186;130912.3454382722;131924;132627;134371;137702;122299;122974.38512807558;123916.9999999982;124118;127017;8948.68679596211;8949.149830766068;8990.550472476481;9077.549231083478;9107;50393.33086772723;62994;67069.99395008982;67234.66382668055;69209;63338.683306583174;65082;68239.31760682528;94391.52804235935;95709;11485.736568977572;11871.643850684493;11878.406079696153;11911.285322880654;11998.280103193836;11685.824712629148;12855.292958886977;12885.871141288842;13140.540081097115;13621.591352259447;9793.412395256308;12092.576759813364;12233.510659573518;12374.319412432042;12637.115401922145;12171.939140304596;12190.75618487643;12358.62924112278;12690.619281421572;12772.489100435878;11765.470553824927;12049.457774399998;12133.170159094812;12244.816327755269;12570.622881313575;9769.364991275545;10061.24540659468;10152.238582106223;10289.073983341535;10557.049865512141;8587.730541026123;8896.955515222642;9487.478188699688;10479.94760026195;10489.580416783243 06:33:08 INFO - PROCESS | 1650 | __end_tp_report 06:33:08 INFO - PROCESS | 1650 | __start_cc_report 06:33:08 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,394 06:33:08 INFO - PROCESS | 1650 | __end_cc_report 06:33:08 INFO - PROCESS | 1650 | __startTimestamp1472563988435__endTimestamp 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | ------- Summary: start ------- 06:33:08 INFO - PROCESS | 1650 | Number of tests: 6 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5755.96 Median:5891.35 stddev:654.82 (11.1%) stddev-sans-first:629.64 06:33:08 INFO - PROCESS | 1650 | Values: 3375.6 3404.3 3428.9 3436.9 3442.9 5684.6 5691.8 5766.2 5791.3 5798.5 5740.7 5754.3 5771.4 5810.0 5817.7 5172.5 5301.7 5303.5 5384.9 5407.3 4479.9 4621.8 4847.7 5092.3 5462.1 4493.9 5168.1 5179.7 5193.6 5281.2 5214.4 5241.2 5243.6 5250.3 5303.6 5274.5 5287.3 5288.0 5291.9 5308.0 5693.5 5709.2 5777.1 5795.5 5873.3 5386.4 6099.2 6222.8 6290.5 6300.9 6270.5 6326.8 6330.6 6333.3 6360.7 5735.3 5794.4 5806.2 5816.5 5848.8 5289.7 6258.1 6264.2 6273.4 6273.7 6179.8 6193.5 6193.9 6195.0 6206.3 6073.5 6157.8 6250.8 6263.7 6291.7 5100.9 6216.7 6249.5 6271.1 6315.3 6220.8 6250.7 6273.4 6295.2 6307.5 4824.2 4909.7 4926.0 4963.6 5003.9 4409.4 4461.7 4465.0 4486.7 4520.9 5709.3 5806.6 5808.7 5845.7 5853.2 6153.7 6224.6 6270.4 6289.3 6298.2 5811.1 5840.3 5843.9 5877.3 5891.4 5436.8 5449.8 5463.4 5473.2 5490.8 6223.2 6235.7 6246.1 6291.1 6331.9 5755.4 5869.0 6275.7 6342.9 6344.7 6255.2 6297.3 6332.3 6342.2 6347.6 6098.0 6161.9 6185.2 6212.3 6231.2 6256.6 6266.6 6277.5 6278.7 6350.8 6208.1 6210.3 6219.7 6245.9 6259.4 6109.5 6143.1 6154.7 6197.4 6233.7 5416.8 5604.5 6095.7 6118.3 6143.5 6203.3 6219.0 6255.4 6260.3 6264.0 5842.9 6019.8 6038.2 6098.5 6108.1 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:70803.21 Median:38922.53 stddev:159176.97 (409.0%) stddev-sans-first:159535.98 06:33:08 INFO - PROCESS | 1650 | Values: 499.3 506.4 513.5 515.5 564.1 32274.5 34248.5 40335.2 40353.0 40387.8 37258.8 40758.0 40970.4 41030.4 41145.8 9679.5 9899.9 9903.2 9909.2 9910.3 9761.7 9865.1 9865.9 9879.0 9899.1 9822.1 9862.8 9866.0 9919.7 9960.5 9863.1 9879.4 9883.7 9886.5 9903.4 9786.5 9864.5 9868.6 9870.8 9895.3 38182.6 38888.4 39065.4 39135.2 39338.6 3259.8 3266.5 3295.3 3422.5 3604.9 24520.5 30246.7 30470.0 30945.0 31098.0 2661.6 3211.2 3218.5 3226.2 3353.7 502814.0 507449.0 507919.0 509009.9 509773.0 56160.7 56445.7 56500.4 56519.7 56654.7 31017.7 31726.8 31842.7 59393.4 59439.0 15274.8 15368.0 15495.4 15543.2 15599.7 11741.1 11851.9 11860.6 11873.6 11895.9 18674.8 18686.0 18856.6 18905.5 18948.3 7631.5 7763.0 7770.8 7805.4 7834.5 728.9 857.7 980.4 1011.4 1022.8 29501.7 29561.6 29853.3 30314.8 30489.9 1033.0 1047.9 1056.8 1104.9 1127.0 13401.3 14954.9 15001.6 15202.5 15486.3 542359.3 697344.0 698663.0 700210.0 700542.0 55894.2 55932.0 56199.0 56348.7 56553.0 1120.8 1340.4 1358.8 1363.5 1366.5 27916.6 29241.3 29411.4 29777.9 30246.5 47166.5 47511.3 47716.0 47737.8 47884.5 590484.0 590667.0 593782.0 594117.0 597409.0 25875.2 26071.6 26110.3 26143.2 26196.9 44950.1 45524.8 46653.8 46711.0 47253.3 38142.6 38181.8 38372.0 38750.9 39680.8 37495.8 37810.1 37909.8 38956.6 39033.6 27532.4 37168.0 37522.1 38050.8 39879.4 30778.8 33580.8 33818.0 33904.0 34007.8 24758.3 25223.5 25403.1 25528.5 25671.7 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:33709.76 Median:2918.30 stddev:95137.13 (3260.0%) stddev-sans-first:95370.96 06:33:08 INFO - PROCESS | 1650 | Values: 312.0 322.4 365.2 379.0 395.0 19103.9 19414.5 20820.8 20993.2 21089.6 19691.2 19998.4 20613.1 20751.6 20908.2 5926.3 6018.5 6074.2 6151.1 6168.4 5858.0 5966.6 6018.9 6037.2 6068.1 5515.8 5810.7 5998.6 6004.1 6015.0 5765.4 5848.7 5868.6 5874.9 5901.1 5636.5 5766.8 5790.2 5798.4 5825.1 12776.5 12986.9 13141.2 13152.5 13204.3 2239.5 2375.1 2442.6 2861.0 2975.6 10061.3 10072.2 10388.8 12669.1 14943.9 1474.8 1843.1 1850.5 1861.5 1903.2 107042.0 127748.7 128542.4 128902.6 129155.0 9090.6 9277.4 11095.1 11200.8 11266.0 11793.5 12110.0 13648.5 14065.0 14285.4 6731.7 6772.5 7988.9 8142.6 8227.7 7888.5 7891.9 7906.9 8055.5 8056.0 3941.7 4271.2 4311.1 4484.1 4529.0 1800.0 1928.8 1931.8 1943.9 1945.6 837.3 906.3 911.4 952.9 985.0 19775.9 19897.8 20461.3 20524.1 20721.1 867.1 870.6 936.9 942.5 946.3 10402.7 10882.2 10909.4 10913.5 10924.5 537305.0 549024.0 568997.7 590644.0 591347.0 104757.5 106531.0 124508.9 128091.0 131906.7 823.5 955.2 997.7 998.2 1032.6 18188.9 18666.1 18977.6 19093.7 19584.7 54315.7 54872.0 55499.0 56144.0 56628.4 74091.0 75841.6 80186.0 80229.6 81344.2 7822.9 7848.7 8006.8 8015.6 8075.3 10781.3 12316.4 12668.1 12717.7 12753.7 10728.6 10784.1 10930.2 11043.1 11188.4 9917.6 10123.7 10451.7 10535.9 11083.3 10933.5 11249.3 11249.7 11379.4 11452.6 6401.6 7721.9 7811.8 7923.7 8145.7 9874.0 10544.5 10850.8 11095.4 11117.9 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5584.89 Median:4928.90 stddev:3109.86 (63.1%) stddev-sans-first:3102.78 06:33:08 INFO - PROCESS | 1650 | Values: 1412.5 1500.2 1646.7 1701.2 1871.7 7852.4 8473.0 8485.6 8904.0 8913.1 8683.0 8760.3 8771.0 8781.8 8783.9 2357.5 2375.3 2376.7 2379.3 2381.2 2264.6 2292.7 2310.0 2312.0 2313.3 2348.3 2351.6 2353.1 2377.4 2379.0 2335.7 2337.6 2343.8 2349.3 2355.9 2334.5 2345.7 2348.2 2348.3 2350.3 8703.6 8774.6 8819.7 8827.6 8849.3 4448.0 4576.7 4769.7 5065.8 5083.4 2949.9 3101.8 3171.3 3249.7 3548.5 979.8 1027.7 1031.1 1097.1 1121.8 10799.5 10845.2 10912.2 10923.3 10939.4 4123.9 4543.1 4680.8 4691.4 4717.2 8466.6 8752.3 9308.6 9342.5 9376.4 5089.9 5168.5 5170.3 5177.2 5182.3 4363.5 4704.9 4764.2 4830.1 4836.8 3859.4 3876.6 3964.3 3971.6 3982.6 1275.5 1281.1 1291.4 1293.5 1293.7 848.3 850.2 911.9 912.5 927.8 5294.2 5620.5 5861.0 5931.9 5981.6 913.5 934.7 938.0 943.5 954.5 3462.2 3790.9 3857.9 3946.9 4046.9 10333.2 10629.9 10640.6 10641.3 10644.6 10544.9 10620.2 10626.3 10642.9 10654.6 7696.0 8051.2 8124.5 8141.4 8144.5 5777.8 5929.9 5970.5 6064.4 6113.1 9543.3 9706.2 9776.6 9850.8 9997.3 9691.5 9753.6 9979.3 10021.3 10132.1 6864.9 7213.8 7363.3 7391.9 7535.0 8197.8 8266.9 8271.8 8278.0 8301.7 7221.7 7383.3 7401.7 7458.0 7475.4 7009.1 7181.5 7228.2 7233.6 7235.5 6816.1 6875.2 6941.7 6941.9 6960.0 4680.7 4863.3 4889.5 4917.7 4988.3 4779.5 4800.5 4864.5 4940.1 4976.5 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4553.04 Median:4891.91 stddev:1451.13 (29.7%) stddev-sans-first:1419.67 06:33:08 INFO - PROCESS | 1650 | Values: 301.0 307.2 313.0 314.1 318.6 4424.4 4818.7 4885.8 4961.8 5207.4 4678.0 5338.8 5389.5 5671.4 5674.8 3538.3 3606.6 4028.5 4201.6 4283.0 3555.5 3992.8 4026.7 4203.3 4258.7 3715.5 3842.9 3930.7 4159.0 4212.4 3520.8 4074.8 4173.5 4181.5 4196.8 3660.6 3680.4 3692.4 3701.5 3707.5 5222.1 5240.8 5289.4 5336.0 5379.5 4827.0 4834.2 4856.9 4871.9 4891.1 4916.4 4961.7 5192.4 5882.6 5927.3 3229.8 3574.2 3849.4 3858.5 3873.6 5409.7 5865.9 6055.9 6074.7 6128.7 3932.4 3947.0 3953.5 3987.8 4007.8 3340.3 3853.3 3979.6 3993.2 4011.9 4136.8 4683.4 4757.5 4763.5 4772.2 4892.7 5884.3 5894.2 5934.2 5954.8 1164.4 1218.7 1343.9 1361.4 1365.7 804.3 821.8 829.5 835.6 837.6 3751.6 4108.7 4545.0 4611.8 4633.7 4568.6 5010.6 5078.6 5112.5 5144.8 4566.9 4595.1 4621.2 4651.8 4671.3 2434.1 2454.8 2661.6 2707.8 2712.7 4367.9 4824.7 5027.9 5164.9 5275.4 4409.3 4766.0 5139.4 5169.1 5232.7 5569.9 6045.9 6180.5 6297.3 6327.3 6004.8 6084.9 6094.7 6117.4 6122.9 5806.7 5970.6 5995.2 6039.9 6056.3 6226.3 6251.9 6272.9 6284.5 6336.7 3361.8 3953.0 3967.7 3972.4 4000.7 5788.2 6022.3 6054.7 6059.0 6174.6 5433.9 5544.6 5665.3 5698.2 5765.5 4396.3 5111.7 5759.0 5835.7 5855.9 5333.5 5640.8 5687.2 5708.5 5747.5 5309.4 5832.7 5924.0 5947.9 6029.6 4677.5 5066.9 5243.3 5527.3 5781.3 06:33:08 INFO - PROCESS | 1650 | 06:33:08 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:24680.58 Median:3829.76 stddev:40101.25 (1047.1%) stddev-sans-first:40173.11 06:33:08 INFO - PROCESS | 1650 | Values: 635.2 638.3 700.1 737.1 802.5 15235.4 16387.3 16388.0 16407.3 16424.9 14909.8 15002.8 15010.4 15042.3 15319.7 683.3 842.9 847.6 853.6 871.8 855.6 857.5 860.1 861.2 863.8 908.4 917.8 919.4 919.7 921.4 877.0 883.1 907.3 911.5 916.3 675.0 682.6 683.6 684.2 687.0 14956.9 14973.0 14997.9 15005.5 15015.2 14316.1 14341.4 14353.4 14357.4 14556.4 11878.3 11968.0 12101.2 12234.8 12455.3 3750.3 3760.4 3899.1 3924.0 3933.0 119297.0 119441.8 120280.0 120346.0 124922.4 10751.4 10850.2 10929.7 11085.7 11547.0 22775.4 22782.9 22812.7 22833.5 22839.4 7509.8 7803.7 7811.2 7828.1 8037.5 4358.5 4425.2 4488.3 4539.8 4626.7 3312.3 3428.4 3528.5 3625.4 3671.0 666.0 677.6 683.5 700.3 703.0 593.9 659.4 659.8 665.7 669.6 9007.8 9292.2 9372.0 9372.6 9547.8 642.9 662.7 672.5 674.5 682.9 4400.6 4626.8 4630.5 4701.7 4712.1 86854.0 114632.4 130896.0 161677.0 168186.0 130912.3 131924.0 132627.0 134371.0 137702.0 122299.0 122974.4 123917.0 124118.0 127017.0 8948.7 8949.1 8990.6 9077.5 9107.0 50393.3 62994.0 67070.0 67234.7 69209.0 63338.7 65082.0 68239.3 94391.5 95709.0 11485.7 11871.6 11878.4 11911.3 11998.3 11685.8 12855.3 12885.9 13140.5 13621.6 9793.4 12092.6 12233.5 12374.3 12637.1 12171.9 12190.8 12358.6 12690.6 12772.5 11765.5 12049.5 12133.2 12244.8 12570.6 9769.4 10061.2 10152.2 10289.1 10557.0 8587.7 8897.0 9487.5 10479.9 10489.6 06:33:08 INFO - PROCESS | 1650 | -------- Summary: end -------- 06:33:08 INFO - PROCESS | 1650 | 06:33:09 INFO - TEST-INFO | 1650: exit 0 06:33:09 INFO - TEST-OK | dromaeo_css | took 1113885ms 06:33:09 INFO - TEST-START | kraken 06:33:09 INFO - operating with platform_type : mac_ 06:33:09 INFO - Initialising browser for kraken test... 06:33:09 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpOo0MhL/profile http://localhost:49275/getInfo.html) 06:33:11 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:33:11 INFO - PROCESS | 1662 | colorDepth:24 06:33:11 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:33:11 INFO - PROCESS | 1662 | __metrics 06:33:11 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 06:33:12 INFO - TEST-INFO | 1662: exit 0 06:33:12 INFO - Browser initialized. 06:33:12 INFO - Running cycle 1/1 for kraken test... 06:33:12 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpOo0MhL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:24 INFO - PROCESS | 1664 | RSS: Main: 244150272 06:33:24 INFO - PROCESS | 1664 | 06:33:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:33:28 INFO - PROCESS | 1664 | RSS: Main: 257208320 06:33:28 INFO - PROCESS | 1664 | 06:33:30 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:33:31 INFO - PROCESS | 1664 | RSS: Main: 265801728 06:33:31 INFO - PROCESS | 1664 | 06:33:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:33:35 INFO - PROCESS | 1664 | RSS: Main: 263528448 06:33:35 INFO - PROCESS | 1664 | 06:33:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:33:37 INFO - PROCESS | 1664 | RSS: Main: 264830976 06:33:37 INFO - PROCESS | 1664 | 06:33:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:33:40 INFO - PROCESS | 1664 | RSS: Main: 266530816 06:33:40 INFO - PROCESS | 1664 | 06:33:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:33:43 INFO - PROCESS | 1664 | RSS: Main: 267567104 06:33:43 INFO - PROCESS | 1664 | 06:33:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:33:47 INFO - PROCESS | 1664 | RSS: Main: 267739136 06:33:47 INFO - PROCESS | 1664 | 06:33:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:33:51 INFO - PROCESS | 1664 | RSS: Main: 267915264 06:33:51 INFO - PROCESS | 1664 | 06:33:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:33:53 INFO - PROCESS | 1664 | RSS: Main: 267522048 06:33:53 INFO - PROCESS | 1664 | 06:33:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:33:56 INFO - PROCESS | 1664 | RSS: Main: 266993664 06:33:56 INFO - PROCESS | 1664 | 06:33:58 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:33:59 INFO - PROCESS | 1664 | RSS: Main: 267292672 06:33:59 INFO - PROCESS | 1664 | 06:34:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:02 INFO - PROCESS | 1664 | RSS: Main: 267579392 06:34:02 INFO - PROCESS | 1664 | 06:34:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:06 INFO - PROCESS | 1664 | RSS: Main: 268075008 06:34:06 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:34:08 INFO - PROCESS | 1664 | RSS: Main: 269975552 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | __start_tp_report 06:34:08 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 06:34:08 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 06:34:08 INFO - PROCESS | 1664 | |i|pagename|runs| 06:34:08 INFO - PROCESS | 1664 | |0;ai-astar;115;112;117;116;120;101;118;117;117;117 06:34:08 INFO - PROCESS | 1664 | |1;audio-beat-detection;146;109;139;160;112;137;154;138;197;115 06:34:08 INFO - PROCESS | 1664 | |2;audio-dft;199;198;203;211;220;195;195;195;196;224 06:34:08 INFO - PROCESS | 1664 | |3;audio-fft;83;86;74;148;60;59;59;64;133;59 06:34:08 INFO - PROCESS | 1664 | |4;audio-oscillator;69;73;118;71;70;83;109;68;74;111 06:34:08 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;107;87;91;87;91;87;91;89;90;86 06:34:08 INFO - PROCESS | 1664 | |6;imaging-darkroom;96;98;95;121;150;113;97;97;113;123 06:34:08 INFO - PROCESS | 1664 | |7;imaging-desaturate;128;91;138;131;92;92;93;90;92;127 06:34:08 INFO - PROCESS | 1664 | |8;json-parse-financial;57;59;57;57;58;58;55;59;58;56 06:34:08 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;80;65;69;122;115;105;76;72;69;60 06:34:08 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;89;88;88;96;108;112;87;93;91;75 06:34:08 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;142;142;142;152;162;141;146;144;176;157 06:34:08 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;209;164;230;241;200;173;178;177;174;173 06:34:08 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;68;67;70;68;71;66;69;69;68;69 06:34:08 INFO - PROCESS | 1664 | __end_tp_report 06:34:08 INFO - PROCESS | 1664 | __start_cc_report 06:34:08 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,967 06:34:08 INFO - PROCESS | 1664 | __end_cc_report 06:34:08 INFO - PROCESS | 1664 | __startTimestamp1472564048374__endTimestamp 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | ------- Summary: start ------- 06:34:08 INFO - PROCESS | 1664 | Number of tests: 14 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:115.00 Median:117.00 stddev:5.33 (4.6%) stddev-sans-first:5.66 06:34:08 INFO - PROCESS | 1664 | Values: 115.0 112.0 117.0 116.0 120.0 101.0 118.0 117.0 117.0 117.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:142.50 stddev:26.37 (18.5%) stddev-sans-first:27.90 06:34:08 INFO - PROCESS | 1664 | Values: 146.0 109.0 139.0 160.0 112.0 137.0 154.0 138.0 197.0 115.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:203.60 Median:201.00 stddev:10.92 (5.4%) stddev-sans-first:11.45 06:34:08 INFO - PROCESS | 1664 | Values: 199.0 198.0 203.0 211.0 220.0 195.0 195.0 195.0 196.0 224.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:82.50 Median:62.00 stddev:32.37 (52.2%) stddev-sans-first:34.33 06:34:08 INFO - PROCESS | 1664 | Values: 83.0 86.0 74.0 148.0 60.0 59.0 59.0 64.0 133.0 59.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:84.60 Median:70.50 stddev:19.93 (28.3%) stddev-sans-first:20.32 06:34:08 INFO - PROCESS | 1664 | Values: 69.0 73.0 118.0 71.0 70.0 83.0 109.0 68.0 74.0 111.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:89.50 stddev:6.08 (6.8%) stddev-sans-first:2.05 06:34:08 INFO - PROCESS | 1664 | Values: 107.0 87.0 91.0 87.0 91.0 87.0 91.0 89.0 90.0 86.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:95.50 stddev:17.67 (18.5%) stddev-sans-first:17.97 06:34:08 INFO - PROCESS | 1664 | Values: 96.0 98.0 95.0 121.0 150.0 113.0 97.0 97.0 113.0 123.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:107.40 Median:91.50 stddev:20.53 (22.4%) stddev-sans-first:20.37 06:34:08 INFO - PROCESS | 1664 | Values: 128.0 91.0 138.0 131.0 92.0 92.0 93.0 90.0 92.0 127.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.26 (2.2%) stddev-sans-first:1.33 06:34:08 INFO - PROCESS | 1664 | Values: 57.0 59.0 57.0 57.0 58.0 58.0 55.0 59.0 58.0 56.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:83.30 Median:69.00 stddev:22.24 (32.2%) stddev-sans-first:23.56 06:34:08 INFO - PROCESS | 1664 | Values: 80.0 65.0 69.0 122.0 115.0 105.0 76.0 72.0 69.0 60.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:88.50 stddev:10.67 (12.1%) stddev-sans-first:11.23 06:34:08 INFO - PROCESS | 1664 | Values: 89.0 88.0 88.0 96.0 108.0 112.0 87.0 93.0 91.0 75.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:149.00 stddev:11.53 (7.7%) stddev-sans-first:11.82 06:34:08 INFO - PROCESS | 1664 | Values: 142.0 142.0 142.0 152.0 162.0 141.0 146.0 144.0 176.0 157.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.90 Median:189.00 stddev:26.77 (14.2%) stddev-sans-first:27.67 06:34:08 INFO - PROCESS | 1664 | Values: 209.0 164.0 230.0 241.0 200.0 173.0 178.0 177.0 174.0 173.0 06:34:08 INFO - PROCESS | 1664 | 06:34:08 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 06:34:08 INFO - PROCESS | 1664 | Values: 68.0 67.0 70.0 68.0 71.0 66.0 69.0 69.0 68.0 69.0 06:34:08 INFO - PROCESS | 1664 | -------- Summary: end -------- 06:34:08 INFO - PROCESS | 1664 | 06:34:09 INFO - TEST-INFO | 1664: exit 0 06:34:09 INFO - TEST-OK | kraken | took 60168ms 06:34:09 INFO - SUITE-END | took 1174s 06:34:09 INFO - Completed test suite (00:19:34) 06:34:09 INFO - javascript benchmark 06:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7259.952683679624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.5949286085665, 3404.3021180657965, 3428.948565771513, 3436.879709210175, 3442.896713098608, 5684.630499017561, 5691.772329106836, 5766.2215600893815, 5791.333996590393, 5798.507126894214, 5740.741666625001, 5754.251947246862, 5771.365149833515, 5810.012297909355, 5817.650940943547, 5172.534471897528, 5301.7084060376665, 5303.522682958533, 5384.892302153955, 5407.270018547505, 4479.888002799939, 4621.821435533934, 4847.684900481458, 5092.312537807404, 5462.071447853875, 4493.943923178051, 5168.095583272912, 5179.689218646856, 5193.558547523465, 5281.155015197569, 5214.400343960455, 5241.24002019705, 5243.580513558906, 5250.291210686547, 5303.575713942875, 5274.525292723673, 5287.312649355597, 5288.0, 5291.86770330741, 5308.044551980642, 5693.516051135658, 5709.172170035363, 5777.133429985493, 5795.507381872546, 5873.2658417697785, 5386.434424385422, 6099.207103076572, 6222.782202622887, 6290.528210384239, 6300.936990630081, 6270.529710271702, 6326.841828954267, 6330.620162790247, 6333.334999824998, 6360.650164240965, 5735.254416925814, 5794.362620111784, 5806.187133801272, 5816.47651711348, 5848.795292164839, 5289.656172348785, 6258.123862659231, 6264.154339164154, 6273.435390814849, 6273.749050038039, 6179.81460556184, 6193.504519638418, 6193.876122477525, 6194.9690251549355, 6206.286277078194, 6073.453389194994, 6157.8460538486, 6250.812475625738, 6263.686815659199, 6291.6854157291955, 5100.948990510047, 6216.720247588869, 6249.531285153632, 6271.122042913996, 6315.305316415191, 6220.844478888064, 6250.656213908279, 6273.372662733781, 6295.181626388632, 6307.4954003679595, 4824.179889418807, 4909.68087074339, 4926.0, 4963.553280204799, 5003.9241563064115, 4409.404730361424, 4461.687681862303, 4464.955350446519, 4486.730796152176, 4520.88697782558, 5709.286339207599, 5806.593538452352, 5808.709564521757, 5845.743165219498, 5853.180554722342, 6153.7384836108495, 6224.595401298901, 6270.372962703785, 6289.339619339995, 6298.212723409574, 5811.099279611667, 5840.328362238312, 5843.941560584425, 5877.294724633071, 5891.351951285355, 5436.836894893159, 5449.782008719686, 5463.4263402342185, 5473.17902314656, 5490.835274941758, 6223.159873417031, 6235.688215589294, 6246.094316324198, 6291.056341548713, 6331.905021424683, 5755.395683453177, 5869.002269614261, 6275.717592708248, 6342.936570634234, 6344.682765861596, 6255.24937007562, 6297.307296197323, 6332.271788744353, 6342.207224096988, 6347.619142851444, 6097.969510152421, 6161.907571386343, 6185.226846644169, 6212.254529456313, 6231.22109736283, 6256.593321434092, 6266.592671476339, 6277.497800176066, 6278.717457714505, 6350.7777227796805, 6208.068789681584, 6210.347913469021, 6219.657918814509, 6245.8757423662355, 6259.436650701458, 6109.495762817132, 6143.109249158936, 6154.723037463235, 6197.442230199304, 6233.719482623203, 5416.835380393234, 5604.523615492566, 6095.695215239309, 6118.265808103056, 6143.477804386677, 6203.286622038343, 6219.036049412348, 6255.374462553708, 6260.28006779208, 6263.96868015657, 5842.853928651818, 6019.789307374221, 6038.184845045863, 6098.451139397298, 6108.144859719554], "value": 5714.84471164103, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.26256626938255, 506.4125614287427, 513.524989384819, 515.5257163409665, 564.134054226762, 32274.515882261756, 34248.48627270593, 40335.19329613406, 40353.0, 40387.79806100969, 37258.8137059315, 40758.0, 40970.38544421836, 41030.38454423178, 41145.79427102868, 9679.467629280387, 9899.851502227473, 9903.207743380512, 9909.157721593638, 9910.256730745186, 9761.707148785512, 9865.112139907444, 9865.90134098657, 9878.962708915567, 9899.059589339002, 9822.116009559139, 9862.753431164207, 9866.013398660149, 9919.652812151577, 9960.452175130366, 9863.112319891208, 9879.407235565888, 9883.703488895344, 9886.456244906527, 9903.405795652248, 9786.510674466248, 9864.457454839981, 9868.60525578976, 9870.753231169207, 9895.257855660782, 38182.618173818184, 38888.44446222148, 39065.41401878974, 39135.21729565393, 39338.60661393378, 3259.8044117353033, 3266.487903647063, 3295.307985323085, 3422.4866270059442, 3604.945925811115, 24520.509589808105, 30246.69753302461, 30470.0, 30945.0, 31098.0, 2661.574148136289, 3211.1811488070625, 3218.4850423932057, 3226.2257058306072, 3353.6814002669707, 502814.0, 507449.0, 507918.99999999633, 509009.9099009, 509773.0, 56160.71919640457, 56445.71777141088, 56500.43499564952, 56519.71740141355, 56654.716726416926, 31017.689823101933, 31726.841365793483, 31842.681573184436, 59393.40606593879, 59439.0, 15274.847251527342, 15368.0, 15495.380184792482, 15543.222838858012, 15599.688006239812, 11741.06071514294, 11851.88148118525, 11860.644180674593, 11873.643790686294, 11895.88104118965, 18674.813251867577, 18685.972271525196, 18856.642919635047, 18905.527361816065, 18948.336808211647, 7631.54210747357, 7763.029621297338, 7770.805729856799, 7805.41459390548, 7834.451588388758, 728.9271072892774, 857.7169534053747, 980.3872579637726, 1011.3628414099071, 1022.823752684404, 29501.704982950327, 29561.55657665137, 29853.253668658024, 30314.84842575773, 30489.932852350063, 1033.03927347566, 1047.8690163729534, 1056.7675111475462, 1104.939228342433, 1126.9887301127048, 13401.329933503286, 14954.850451495564, 15001.624959375884, 15202.46791362297, 15486.303116359792, 542359.2882035644, 697344.0, 698663.0, 700210.0, 700542.0, 55894.16158757622, 55932.0, 56199.0, 56348.71825640927, 56553.0, 1120.8318752187238, 1340.4169186403944, 1358.77580199266, 1363.5023216525897, 1366.5148872150244, 27916.58125128084, 29241.268968275963, 29411.411771764873, 29777.85111074431, 30246.54630180505, 47166.52833471759, 47511.287330689374, 47716.0, 47737.76131119322, 47884.5211547894, 590484.0, 590667.0, 593782.0, 594117.0, 597409.0, 25875.22374328773, 26071.60892586575, 26110.34724131912, 26143.215703528924, 26196.86901565556, 44950.1009979792, 45524.77237613791, 46653.76673116613, 46711.0, 47253.2912006327, 38142.61857381391, 38181.80909095437, 38372.0, 38750.89354001864, 39680.801595991834, 37495.812520938314, 37810.054748631504, 37909.81045094757, 38956.61043389643, 39033.609663904135, 27532.449351012467, 37168.0, 37522.06194845041, 38050.80974595109, 39879.40180897231, 30778.846105769328, 33580.83209583937, 33818.0, 33903.98288051363, 34007.82996085004, 24758.25725228246, 25223.495530088927, 25403.110891118722, 25528.489430211663, 25671.74328256768], "value": 19509.322550186855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.98752049918005, 322.37459328901946, 365.2421225956141, 378.98484060637577, 395.00064835965003, 19103.904480477595, 19414.514637134078, 20820.791792082076, 20993.160273589037, 21089.57820843586, 19691.212351505957, 19998.400047998548, 20613.07241174147, 20751.584968300624, 20908.16367345308, 5926.318473375563, 6018.548608854331, 6074.179985701918, 6151.077338399254, 6168.414000669952, 5858.0, 5966.642001479903, 6018.939810601903, 6037.154798328237, 6068.059450785136, 5515.834524964257, 5810.6513609183585, 5998.55010874184, 6004.129401236818, 6015.0, 5765.365809760923, 5848.736806843703, 5868.618539794899, 5874.9118763218585, 5901.114832775075, 5636.4927156556105, 5766.826995190151, 5790.160426738099, 5798.362180160179, 5825.067989121762, 12776.488940442372, 12986.935065324707, 13141.211527308296, 13152.473901044043, 13204.273764942924, 2239.5185035217505, 2375.0873558318995, 2442.6091825308044, 2861.0, 2975.598294230273, 10061.346012509164, 10072.244581656405, 10388.844167337496, 12669.113162078658, 14943.925280373638, 1474.793528905954, 1843.0968825275652, 1850.5466160790693, 1861.450871992752, 1903.1530968718926, 107042.0, 127748.7225127746, 128542.3572882139, 128902.62132961328, 129155.0, 9090.636374545076, 9277.443353398818, 11095.1123910087, 11200.831987520194, 11266.042386397085, 11793.469293881624, 12109.970652494636, 13648.454061837416, 14065.0, 14285.357158927873, 6731.663416829139, 6772.525923185428, 7988.920110798817, 8142.552159631158, 8227.670893164206, 7888.526688398714, 7891.881621775678, 7906.881396779053, 8055.516668999879, 8055.972013993003, 3941.7437866538585, 4271.188474189894, 4311.137772445523, 4484.148011877733, 4528.977355113203, 1799.9550011249823, 1928.7685477742762, 1931.758530183727, 1943.8736482128616, 1945.5914258005694, 837.3468694418364, 906.3066753933247, 911.382296423853, 952.9190018848476, 984.9950750246203, 19775.901120494305, 19897.801021989886, 20461.283855065, 20524.07641656129, 20721.067551960197, 867.137198487509, 870.6082262981557, 936.9016253293443, 942.4910548303976, 946.3375637053952, 10402.687919362432, 10882.23824332305, 10909.39998300101, 10913.454327283764, 10924.453777311102, 537305.0, 549024.0, 568997.7051262137, 590644.0, 591347.0, 104757.47621261998, 106531.0, 124508.94620280009, 128091.0, 131906.68093319135, 823.5017814222429, 955.2310390136007, 997.7405874472689, 998.1715176403568, 1032.5921261101823, 18188.909055455166, 18666.066696665384, 18977.620447591245, 19093.713594296376, 19584.706229406856, 54315.72842135922, 54872.0, 55499.0, 56144.0, 56628.433715662315, 74091.0, 75841.6207918957, 80186.0, 80229.59885200537, 81344.18655813366, 7822.921770782219, 7848.725294614661, 8006.799830004296, 8015.599220039091, 8075.273225409741, 10781.299215550964, 12316.445759941003, 12668.072897401835, 12717.682057948625, 12753.681157971125, 10728.570857165625, 10784.083352914777, 10930.234883558074, 11043.061339785887, 11188.440577970907, 9917.603295868084, 10123.696289111338, 10451.68644940653, 10535.894641053797, 11083.334999900031, 10933.507992140532, 11249.268797528135, 11249.718757030812, 11379.43102844871, 11452.599159029394, 6401.551891367746, 7721.884171737541, 7811.843763124592, 7923.7226697065325, 8145.714899978472, 9874.0, 10544.472776360997, 10850.837237441287, 11095.445227738419, 11117.888821111685], "value": 9258.576223375929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.545078569074, 1500.2198856594575, 1646.7118254305494, 1701.2089378439023, 1871.6724573199688, 7852.37181025518, 8472.957635211824, 8485.575721213945, 8904.020557738651, 8913.108689131092, 8683.044865064838, 8760.255378292853, 8770.956145219265, 8781.824363512726, 8783.868241976375, 2357.5402796454655, 2375.287413775869, 2376.702912135983, 2379.2505360811374, 2381.202297230421, 2264.6036943534896, 2292.713410823647, 2309.9884500577473, 2311.9653205201935, 2313.3175713164655, 2348.3072493614427, 2351.6472529120683, 2353.1411034972284, 2377.3581133094053, 2379.0127097254617, 2335.6613291072867, 2337.614293641547, 2343.8359314847967, 2349.283468542094, 2355.9411014724596, 2334.498082912182, 2345.7419683834764, 2348.213348528228, 2348.2720356689483, 2350.2714158610884, 8703.608337624759, 8774.561271936378, 8819.691310804155, 8827.602757875911, 8849.336299777542, 4447.977760111211, 4576.725396476222, 4769.689970151929, 5065.822696205615, 5083.364579427572, 2949.8525073746227, 3101.7673674474504, 3171.349873275973, 3249.6587858275016, 3548.520949671787, 979.8291042204569, 1027.7482016905906, 1031.1338475680463, 1097.1497089755424, 1121.775644871029, 10799.514021868956, 10845.240833141683, 10912.181586381053, 10923.344599324066, 10939.398333091598, 4123.876283711494, 4543.136804007228, 4680.836170734008, 4691.413573303337, 4717.174494463455, 8466.64533674609, 8752.256058234994, 9308.581113849894, 9342.48616326095, 9376.437413755197, 5089.898202036013, 5168.457311982188, 5170.276161337416, 5177.171652535576, 5182.300389447451, 4363.5418281080665, 4704.88237794051, 4764.166270902579, 4830.082284365959, 4836.806527738851, 3859.4017927221325, 3876.5541962674088, 3964.28642844285, 3971.5631280559114, 3982.561918188997, 1275.4770544077069, 1281.128832393981, 1291.3607764156802, 1293.4632127666912, 1293.734784369202, 848.2577744473585, 850.2050582705191, 911.8632205169145, 912.5118061837018, 927.7521733268743, 5294.232336311214, 5620.4660557247, 5861.0, 5931.902598019294, 5981.641101533922, 913.5249670171473, 934.6588495199339, 937.9906200937903, 943.5235206220815, 954.5227386306847, 3462.221000274918, 3790.8673196438544, 3857.9421308680394, 3946.940795888064, 4046.858359957387, 10333.173346132291, 10629.9468502657, 10640.574377024832, 10641.255112142231, 10644.574217031231, 10544.945505449547, 10620.203484738675, 10626.309289896286, 10642.946785266024, 10654.627088052035, 7695.961520192363, 8051.194880511902, 8124.512529248264, 8141.43009989295, 8144.470609410369, 5777.768889244383, 5929.85175370602, 5970.5223582114195, 6064.3935606439, 6113.144159817718, 9543.28425368114, 9706.174975127193, 9776.608935642778, 9850.802983940424, 9997.300188986992, 9691.515424228619, 9753.561089750836, 9979.301448898797, 10021.298509104292, 10132.088112069949, 6864.897026544506, 7213.783586492414, 7363.300486453778, 7391.928170415152, 7535.0, 8197.754067377988, 8266.875996860172, 8271.83456330858, 8278.0, 8301.709440169565, 7221.67502462401, 7383.261673832574, 7401.740939067106, 7458.0, 7475.36459400957, 7009.12385951756, 7181.533200341961, 7228.168760592599, 7233.565986040854, 7235.457340699363, 6816.079829223189, 6875.1749790025515, 6941.687624057031, 6941.895871562032, 6959.965200173967, 4680.672352935262, 4863.294822250683, 4889.511048895224, 4917.729524876167, 4988.276699878425, 4779.5220477951925, 4800.543948324904, 4864.464908860094, 4940.061388336205, 4976.457298237558], "value": 4502.8714488164605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.03218153636067, 307.22425874666465, 312.99843500782487, 314.05939212059883, 318.5699305936984, 4424.446944131983, 4818.711346901257, 4885.828995985141, 4961.801527938883, 5207.427183009866, 4677.976610116944, 5338.813141540047, 5389.461053894618, 5671.376148623658, 5674.773009079642, 3538.274653695999, 3606.6032736398975, 4028.4561584186054, 4201.600847919451, 4282.978585107086, 3555.5022296878456, 3992.800359982004, 4026.6979976501734, 4203.327467605184, 4258.701890867641, 3715.4580848947653, 3842.884713458601, 3930.6855451563806, 4159.043420013399, 4212.431321771553, 3520.77114987525, 4074.7962601870086, 4173.520045194811, 4181.477315335583, 4196.81114349855, 3660.5790334111653, 3680.411134218539, 3692.372296709566, 3701.4632878232505, 3707.4994875691705, 5222.059298655489, 5240.81657142002, 5289.360298307537, 5336.0, 5379.488948549882, 4826.951730482685, 4834.2203233140735, 4856.902861942776, 4871.853844384638, 4891.0951473977075, 4916.434610019858, 4961.677490963076, 5192.416313024526, 5882.646991192007, 5927.347991720907, 3229.7577681673733, 3574.1771696434744, 3849.4225866120028, 3858.4791053207737, 3873.573906870242, 5409.675419474844, 5865.882682346414, 6055.910710804766, 6074.66357401371, 6128.7242074106325, 3932.4297976793205, 3946.973786815449, 3953.545342285674, 3987.7806720630065, 4007.7996100194873, 3340.3319336132386, 3853.2871418787613, 3979.582143874851, 3993.221321842213, 4011.859584914514, 4136.834526618962, 4683.391159149289, 4757.548947571024, 4763.54746299101, 4772.164871147535, 4892.730899800546, 5884.264466941632, 5894.200254878898, 5934.228550288435, 5954.791582294599, 1164.3596022187762, 1218.6587755428495, 1343.9126456780277, 1361.4213959067554, 1365.6858922447893, 804.3364224514798, 821.7904434369317, 829.4572095901618, 835.6364981233183, 837.5770236030766, 3751.606081361472, 4108.712390132662, 4544.954550454519, 4611.79246933882, 4633.675642704979, 4568.565986231302, 5010.592796898144, 5078.568321692624, 5112.488751124858, 5144.768485418165, 4566.931496027562, 4595.080983803253, 4621.197732884178, 4651.790669419885, 4671.27595222741, 2434.062885788984, 2454.779069883719, 2661.574148136289, 2707.7796207110373, 2712.7151649076563, 4367.868963931087, 4824.734639594786, 5027.899442011212, 5164.870878227999, 5275.419703832576, 4409.2724700424715, 4765.976170119127, 5139.383274007143, 5169.061601899288, 5232.712200828991, 5569.860753481195, 6045.939540604538, 6180.505559555225, 6297.27581328144, 6327.272363678144, 6004.849878753066, 6084.908726369196, 6094.695265236632, 6117.388261173847, 6122.938770612237, 5806.712575717447, 5970.58205925581, 5995.2206213192, 6039.909401358896, 6056.273247210363, 6226.25284965807, 6251.937480625317, 6272.905906411316, 6284.517615541927, 6336.651484168415, 3361.781484203519, 3953.0, 3967.7420967637013, 3972.423998520256, 4000.699947504007, 5788.160716695971, 6022.307434644897, 6054.66699331541, 6058.969705151446, 6174.579846635209, 5433.864153396196, 5544.584156188383, 5665.263515742927, 5698.1737648041635, 5765.4522820332, 4396.27461468854, 5111.667741596784, 5759.0209664358, 5835.708214589338, 5855.945929732518, 5333.493318134771, 5640.756564975074, 5687.232223649919, 5708.514776244066, 5747.453991870766, 5309.38942021657, 5832.679202643895, 5924.0, 5947.888499582586, 6029.643330250834, 4677.462091859344, 5066.898662026812, 5243.344581927259, 5527.2538207343105, 5781.306243250837], "value": 4086.9178262653872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.2059925093633, 638.3488841381787, 700.1458220970414, 737.1449119021936, 802.4743792815705, 15235.390584376626, 16387.344506219735, 16388.016718996867, 16407.261673224704, 16424.91787541062, 14909.776353354708, 15002.774958375632, 15010.399584016626, 15042.323095460702, 15319.69360612787, 683.2893790457917, 842.8946381702287, 847.5635047950295, 853.5945425922699, 871.7733389318792, 855.6064210463195, 857.4640849469082, 860.0968982568278, 861.1775754154799, 863.7624653220352, 908.3505293714992, 917.7980844214262, 919.4391421233042, 919.6643225222779, 921.4010892919589, 876.9736907892774, 883.1301168349203, 907.2560500389683, 911.4759013567159, 916.2715641065336, 674.9932500674979, 682.6313790553095, 683.5830143612393, 684.2165720250285, 686.9553479023848, 14956.925215373962, 14973.0, 14997.925010374987, 15005.474808381763, 15015.174165420898, 14316.141031538142, 14341.42634294627, 14353.425862965469, 14357.353919073666, 14556.417743290256, 11878.287302761863, 11967.975129409759, 12101.152919295564, 12234.81647775284, 12455.314957677325, 3750.324941510527, 3760.435934609803, 3899.083715326896, 3924.0, 3932.980335098306, 119297.0, 119441.80558194393, 120280.0, 120346.0, 124922.37538812339, 10751.354918704903, 10850.240483166102, 10929.672109836718, 11085.722856928642, 11547.0, 22775.430614234447, 22782.886085569797, 22812.65781013286, 22833.543329133325, 22839.429014274443, 7509.849803003909, 7803.7268695595385, 7811.218878112143, 7828.099768526692, 8037.477563958324, 4358.5205627380965, 4425.22558552252, 4488.304312831517, 4539.75031373271, 4626.74552899587, 3312.337532493511, 3428.400029994741, 3528.4883691864534, 3625.4199328107375, 3670.9632903671154, 665.9933400666029, 677.6205325018005, 683.5386114372778, 700.2507317170579, 702.9859402811915, 593.8841925824423, 659.423004870738, 659.8086554899025, 665.6571865489277, 669.6049330894796, 9007.813357548512, 9292.16370526656, 9371.953140234391, 9372.62509499626, 9547.761305967406, 642.8521440068811, 662.6653539962289, 672.4788289075907, 674.4536925090692, 682.9112215411965, 4400.625946794558, 4626.814927402934, 4630.513796051433, 4701.694389864648, 4712.081144176853, 86854.0, 114632.42683786528, 130896.0, 161677.0, 168186.0, 130912.3454382722, 131924.0, 132627.0, 134371.0, 137702.0, 122299.0, 122974.38512807558, 123916.9999999982, 124118.0, 127017.0, 8948.68679596211, 8949.149830766068, 8990.550472476481, 9077.549231083478, 9107.0, 50393.33086772723, 62994.0, 67069.99395008982, 67234.66382668055, 69209.0, 63338.683306583174, 65082.0, 68239.31760682528, 94391.52804235935, 95709.0, 11485.736568977572, 11871.643850684493, 11878.406079696153, 11911.285322880654, 11998.280103193836, 11685.824712629148, 12855.292958886977, 12885.871141288842, 13140.540081097115, 13621.591352259447, 9793.412395256308, 12092.576759813364, 12233.510659573518, 12374.319412432042, 12637.115401922145, 12171.939140304596, 12190.75618487643, 12358.62924112278, 12690.619281421572, 12772.489100435878, 11765.470553824927, 12049.457774399998, 12133.170159094812, 12244.816327755269, 12570.622881313575, 9769.364991275545, 10061.24540659468, 10152.238582106223, 10289.073983341535, 10557.049865512141, 8587.730541026123, 8896.955515222642, 9487.478188699688, 10479.94760026195, 10489.580416783243], "value": 7706.925614280402, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 117.0, 116.0, 120.0, 101.0, 118.0, 117.0, 117.0, 117.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 139.0, 160.0, 112.0, 137.0, 154.0, 138.0, 197.0, 115.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 198.0, 203.0, 211.0, 220.0, 195.0, 195.0, 195.0, 196.0, 224.0], "value": 203.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 74.0, 148.0, 60.0, 59.0, 59.0, 64.0, 133.0, 59.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 118.0, 71.0, 70.0, 83.0, 109.0, 68.0, 74.0, 111.0], "value": 84.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 87.0, 91.0, 87.0, 91.0, 87.0, 91.0, 89.0, 90.0, 86.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 121.0, 150.0, 113.0, 97.0, 97.0, 113.0, 123.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 91.0, 138.0, 131.0, 92.0, 92.0, 93.0, 90.0, 92.0, 127.0], "value": 107.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 57.0, 58.0, 58.0, 55.0, 59.0, 58.0, 56.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 65.0, 69.0, 122.0, 115.0, 105.0, 76.0, 72.0, 69.0, 60.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 96.0, 108.0, 112.0, 87.0, 93.0, 91.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 142.0, 152.0, 162.0, 141.0, 146.0, 144.0, 176.0, 157.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 164.0, 230.0, 241.0, 200.0, 173.0, 178.0, 177.0, 174.0, 173.0], "value": 191.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 70.0, 68.0, 71.0, 66.0, 69.0, 69.0, 68.0, 69.0], "value": 68.5, "unit": "score"}]}]} 06:34:09 INFO - Return code: 0 06:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:09 ERROR - # TBPL SUCCESS # 06:34:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:09 INFO - 2016-08-30 06:34:09.712 screenresolution[1669:10334] starting screenresolution argv=screenresolution get 06:34:09 INFO - 2016-08-30 06:34:09.715 screenresolution[1669:10334] Display 0: 1600x1200x32@60 06:34:09 INFO - 2016-08-30 06:34:09.721 screenresolution[1670:10337] starting screenresolution argv=screenresolution list 06:34:09 INFO - Available Modes on Display 0 06:34:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:09 INFO - Intel Iris: 06:34:09 INFO - Chipset Model: Intel Iris 06:34:09 INFO - Type: GPU 06:34:09 INFO - Bus: Built-In 06:34:09 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:09 INFO - Vendor: Intel (0x8086) 06:34:09 INFO - Device ID: 0x0a2e 06:34:09 INFO - Revision ID: 0x0009 06:34:09 INFO - Displays: 06:34:09 INFO - Display: 06:34:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:09 INFO - Display Serial Number: 1600x1200 60 06:34:09 INFO - Main Display: Yes 06:34:09 INFO - Mirror: Off 06:34:09 INFO - Online: Yes 06:34:09 INFO - Rotation: Supported 06:34:09 INFO - Return code: 0 06:34:09 INFO - Running post-action listener: _resource_record_post_action 06:34:09 INFO - [mozharness: 2016-08-30 13:34:09.957034Z] Finished run-tests step (success) 06:34:09 INFO - Running post-run listener: _resource_record_post_run 06:34:10 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37258240; Write bytes: 706614272; Read time: 237; Write time: 1989 06:34:10 INFO - TinderboxPrint: CPU usage
54.6% 06:34:10 INFO - TinderboxPrint: I/O read bytes / time
37,258,240 / 237 06:34:10 INFO - TinderboxPrint: I/O write bytes / time
706,614,272 / 1,989 06:34:10 INFO - TinderboxPrint: CPU idle
2,195.1 (45.4%) 06:34:10 INFO - TinderboxPrint: CPU system
976.3 (20.2%) 06:34:10 INFO - TinderboxPrint: CPU user
1,666.3 (34.4%) 06:34:10 INFO - TinderboxPrint: Swap in / out
443,293,696 / 0 06:34:10 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398758400; Write bytes: 392583168; Read time: 29440; Write time: 787 06:34:10 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 35181568; Write bytes: 297376768; Read time: 218; Write time: 1158 06:34:10 INFO - Running post-run listener: _upload_blobber_files 06:34:10 INFO - Blob upload gear active. 06:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:11 INFO - (blobuploader) - INFO - Done attempting. 06:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:12 INFO - (blobuploader) - INFO - Done attempting. 06:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:14 INFO - (blobuploader) - INFO - Done attempting. 06:34:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:14 INFO - Return code: 0 06:34:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5c48bf08df7a600a1005c101c9dcb43caec154a5d12e21e2c4200c9532f2c70fad51b0626b0df03e9b8c2985734d06b0e50da32301c391a82e70f5a9453497f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a75e7049f3e3c79801745bddf65c1ac35b6d94f82427180dde3eef6d758f341657aedbec4ea416eb662647f8a13117817242028e9f909b0d7074b569603ebd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae17f112d033ec10c487cfa9d73c1d844758f97a630e6c518e49695481e73618d3143f0214c6eb385d8fc06713de84a72b9e7549b510d3808f9528c8dc432551"} 06:34:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:14 INFO - Contents: 06:34:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5c48bf08df7a600a1005c101c9dcb43caec154a5d12e21e2c4200c9532f2c70fad51b0626b0df03e9b8c2985734d06b0e50da32301c391a82e70f5a9453497f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a75e7049f3e3c79801745bddf65c1ac35b6d94f82427180dde3eef6d758f341657aedbec4ea416eb662647f8a13117817242028e9f909b0d7074b569603ebd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae17f112d033ec10c487cfa9d73c1d844758f97a630e6c518e49695481e73618d3143f0214c6eb385d8fc06713de84a72b9e7549b510d3808f9528c8dc432551"} 06:34:14 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:14 INFO - Copying logs to upload dir... 06:34:14 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.041752 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-30 06:34:15.028622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 06:34:15.031810) ========= 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.n0ljApupab/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.OZSBOKmjXg/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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/5c48bf08df7a600a1005c101c9dcb43caec154a5d12e21e2c4200c9532f2c70fad51b0626b0df03e9b8c2985734d06b0e50da32301c391a82e70f5a9453497f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a75e7049f3e3c79801745bddf65c1ac35b6d94f82427180dde3eef6d758f341657aedbec4ea416eb662647f8a13117817242028e9f909b0d7074b569603ebd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae17f112d033ec10c487cfa9d73c1d844758f97a630e6c518e49695481e73618d3143f0214c6eb385d8fc06713de84a72b9e7549b510d3808f9528c8dc432551"} build_url:https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010989 build_url: 'https://queue.taskcluster.net/v1/task/PUB4RRfeSjmbm1gVOAiJ9Q/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/5c48bf08df7a600a1005c101c9dcb43caec154a5d12e21e2c4200c9532f2c70fad51b0626b0df03e9b8c2985734d06b0e50da32301c391a82e70f5a9453497f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a75e7049f3e3c79801745bddf65c1ac35b6d94f82427180dde3eef6d758f341657aedbec4ea416eb662647f8a13117817242028e9f909b0d7074b569603ebd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae17f112d033ec10c487cfa9d73c1d844758f97a630e6c518e49695481e73618d3143f0214c6eb385d8fc06713de84a72b9e7549b510d3808f9528c8dc432551"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 06:34:15.066164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 06:34:15.066574) ========= 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.n0ljApupab/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.OZSBOKmjXg/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 06:34:15.116618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 06:34:15.116968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 06:34:15.117320) ========= ========= Total master_lag: 0.18 =========