builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0284 starttime: 1471626346.85 results: success (0) buildid: 20160819071321 builduid: 291cfaf5f55942c2b854a32cebb91351 revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:46.850144) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:46.850568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-08-19 10:05:46.850863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-08-19 10:05:55.934215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 10:05:55.934546) ========= 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.ceNe9atk3E/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.CxPL6zxGvx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-19 10:05:55-- 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% 13.2M=0.001s 2016-08-19 10:05:56 (13.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.586594 ========= master_lag: 0.62 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 10:05:57.140973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.141299) ========= 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.ceNe9atk3E/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.CxPL6zxGvx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.025482 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.190700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.191032) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ceNe9atk3E/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.CxPL6zxGvx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-19 10:05:57,274 truncating revision to first 12 chars 2016-08-19 10:05:57,274 Setting DEBUG logging. 2016-08-19 10:05:57,274 attempt 1/10 2016-08-19 10:05:57,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/23c2ec5544b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 10:05:57,560 unpacking tar archive at: fx-team-23c2ec5544b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.789359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.789641) ========= script_repo_revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.789999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.790258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 10:05:57.810221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-19 10:05:57.810499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ceNe9atk3E/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.CxPL6zxGvx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:05:57 INFO - MultiFileLogger online at 20160819 10:05:57 in /builds/slave/test 10:05:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:05:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:58 INFO - {'append_to_log': False, 10:05:58 INFO - 'base_work_dir': '/builds/slave/test', 10:05:58 INFO - 'blob_upload_branch': 'Fx-Team', 10:05:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:58 INFO - 'branch': 'Fx-Team', 10:05:58 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:58 INFO - 'config_files': ('talos/mac_config.py',), 10:05:58 INFO - 'default_actions': ('clobber', 10:05:58 INFO - 'read-buildbot-config', 10:05:58 INFO - 'download-and-extract', 10:05:58 INFO - 'populate-webroot', 10:05:58 INFO - 'create-virtualenv', 10:05:58 INFO - 'install', 10:05:58 INFO - 'run-tests'), 10:05:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:58 INFO - 'download_minidump_stackwalk': True, 10:05:58 INFO - 'download_symbols': 'ondemand', 10:05:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:58 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:58 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:58 INFO - 'installer_path': 'installer.exe', 10:05:58 INFO - 'log_level': 'info', 10:05:58 INFO - 'log_name': 'talos', 10:05:58 INFO - 'log_to_console': True, 10:05:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:05:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:05:58 INFO - 'opt_config_files': (), 10:05:58 INFO - 'pip_index': False, 10:05:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:58 INFO - 'cmd': ('bash', 10:05:58 INFO - '-c', 10:05:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:58 INFO - 'enabled': True, 10:05:58 INFO - 'halt_on_failure': False, 10:05:58 INFO - 'name': 'check_screen_resolution'},), 10:05:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:58 INFO - 'cmd': ('bash', 10:05:58 INFO - '-c', 10:05:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:58 INFO - 'enabled': True, 10:05:58 INFO - 'halt_on_failure': False, 10:05:58 INFO - 'name': 'check_screen_resolution'},), 10:05:58 INFO - 'run_cmd_checks_enabled': True, 10:05:58 INFO - 'sps_profile': False, 10:05:58 INFO - 'sps_profile_interval': 0, 10:05:58 INFO - 'suite': 'dromaeojs', 10:05:58 INFO - 'system_bits': '32', 10:05:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:58 INFO - 'title': 't-yosemite-r7-0284', 10:05:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:58 INFO - 'use_talos_json': True, 10:05:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:58 INFO - 'work_dir': 'build'} 10:05:58 INFO - [mozharness: 2016-08-19 17:05:58.007685Z] Running clobber step. 10:05:58 INFO - Running pre-action listener: _resource_record_pre_action 10:05:58 INFO - Running main action method: clobber 10:05:58 INFO - rmtree: /builds/slave/test/build 10:05:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:59 INFO - Running post-action listener: _resource_record_post_action 10:05:59 INFO - [mozharness: 2016-08-19 17:05:59.999415Z] Finished clobber step (success) 10:05:59 INFO - [mozharness: 2016-08-19 17:05:59.999546Z] Running read-buildbot-config step. 10:05:59 INFO - Running pre-action listener: _resource_record_pre_action 10:05:59 INFO - Running main action method: read_buildbot_config 10:06:00 INFO - Using buildbot properties: 10:06:00 INFO - { 10:06:00 INFO - "project": "", 10:06:00 INFO - "product": "firefox", 10:06:00 INFO - "script_repo_revision": "production", 10:06:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:06:00 INFO - "repository": "", 10:06:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:06:00 INFO - "buildid": "20160819071321", 10:06:00 INFO - "pgo_build": "False", 10:06:00 INFO - "basedir": "/builds/slave/test", 10:06:00 INFO - "buildnumber": 94, 10:06:00 INFO - "slavename": "t-yosemite-r7-0284", 10:06:00 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:06:00 INFO - "platform": "yosemite_r7", 10:06:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:06:00 INFO - "branch": "fx-team", 10:06:00 INFO - "repo_path": "integration/fx-team", 10:06:00 INFO - "revision": "23c2ec5544b9e0a74a047b87b594e4c36a8fe95c", 10:06:00 INFO - "stage_platform": "macosx64", 10:06:00 INFO - "builduid": "291cfaf5f55942c2b854a32cebb91351", 10:06:00 INFO - "slavebuilddir": "test" 10:06:00 INFO - } 10:06:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:06:00 INFO - Running post-action listener: _resource_record_post_action 10:06:00 INFO - [mozharness: 2016-08-19 17:06:00.002693Z] Finished read-buildbot-config step (success) 10:06:00 INFO - [mozharness: 2016-08-19 17:06:00.002828Z] Running download-and-extract step. 10:06:00 INFO - Running pre-action listener: _resource_record_pre_action 10:06:00 INFO - Running main action method: download_and_extract 10:06:00 INFO - mkdir: /builds/slave/test/build/tests 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:00 INFO - trying https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:06:00 INFO - Downloading https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:00 INFO - Downloaded 1199 bytes. 10:06:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:06:00 INFO - Using the following test package requirements: 10:06:00 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:06:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:06:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:06:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'jsshell-mac.zip'], 10:06:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:06:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:06:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:06:00 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:06:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:06:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:06:00 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:06:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:00 INFO - trying https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:06:00 INFO - Downloading https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:01 INFO - Downloaded 16350136 bytes. 10:06:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:06:09 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 10:06: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')]} 10:06:09 INFO - trying https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:06:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:10 INFO - Downloaded 16350136 bytes. 10:06: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 10:06:16 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')]} 10:06:16 INFO - trying https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:06:16 INFO - Downloading https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:17 INFO - Downloaded 14413981 bytes. 10:06:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:06: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')]} 10:06:17 INFO - trying https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:06:17 INFO - Downloading https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/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 10:06:20 INFO - Downloaded 111358158 bytes. 10:06:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:06:20 INFO - mkdir: /builds/slave/test/properties 10:06:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:20 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:20 INFO - Contents: 10:06:20 INFO - build_url:https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:06:21 INFO - Running post-action listener: _resource_record_post_action 10:06:21 INFO - Running post-action listener: set_extra_try_arguments 10:06:21 INFO - [mozharness: 2016-08-19 17:06:21.427800Z] Finished download-and-extract step (success) 10:06:21 INFO - [mozharness: 2016-08-19 17:06:21.427939Z] Running populate-webroot step. 10:06:21 INFO - Running pre-action listener: _resource_record_pre_action 10:06:21 INFO - Running main action method: populate_webroot 10:06:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:21 INFO - '--tppagecycles', 10:06:21 INFO - '7'], 10:06:21 INFO - 'tests': ['tsvgm']}}, 10:06:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['damp', 'tps']}, 10:06:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'tests': ['damp', 'tps']}, 10:06:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['dromaeo_dom']}, 10:06:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['basic_compositor_video']}, 10:06:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:06:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['a11yr', 10:06:21 INFO - 'ts_paint', 10:06:21 INFO - 'tpaint', 10:06:21 INFO - 'sessionrestore', 10:06:21 INFO - 'sessionrestore_no_auto_restore', 10:06:21 INFO - 'tabpaint']}, 10:06:21 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:21 INFO - 'ts_paint', 10:06:21 INFO - 'tpaint', 10:06:21 INFO - 'sessionrestore', 10:06:21 INFO - 'sessionrestore_no_auto_restore', 10:06:21 INFO - 'tabpaint']}, 10:06:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:21 INFO - 'ts_paint', 10:06:21 INFO - 'tpaint', 10:06:21 INFO - 'sessionrestore', 10:06:21 INFO - 'sessionrestore_no_auto_restore', 10:06:21 INFO - 'tabpaint']}, 10:06:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:21 INFO - 'ts_paint', 10:06:21 INFO - 'tpaint', 10:06:21 INFO - 'sessionrestore', 10:06:21 INFO - 'sessionrestore_no_auto_restore', 10:06:21 INFO - 'tabpaint']}, 10:06:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['a11yr', 10:06:21 INFO - 'ts_paint', 10:06:21 INFO - 'tpaint', 10:06:21 INFO - 'sessionrestore', 10:06:21 INFO - 'sessionrestore_no_auto_restore', 10:06:21 INFO - 'tabpaint']}, 10:06:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['a11yr', 10:06:21 INFO - 'ts_paint', 10:06:21 INFO - 'tpaint', 10:06:21 INFO - 'sessionrestore', 10:06:21 INFO - 'sessionrestore_no_auto_restore', 10:06:21 INFO - 'tabpaint']}, 10:06:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['tsvgx', 10:06:21 INFO - 'tsvgr_opacity', 10:06:21 INFO - 'tart', 10:06:21 INFO - 'tscrollx', 10:06:21 INFO - 'cart']}, 10:06:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:21 INFO - 'tsvgr_opacity', 10:06:21 INFO - 'tart', 10:06:21 INFO - 'tscrollx', 10:06:21 INFO - 'cart']}, 10:06:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'talos_options': ['--disable-e10s'], 10:06:21 INFO - 'tests': ['tp5o']}, 10:06:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'tests': ['tp5o']}, 10:06:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'talos_options': ['--disable-e10s', 10:06:21 INFO - '--xperf_path', 10:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:21 INFO - 'tests': ['tp5n']}, 10:06:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:21 INFO - 'talos_options': ['--xperf_path', 10:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:21 INFO - 'tests': ['tp5n']}}, 10:06:21 INFO - 'talos.zip': {'path': '', 10:06:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:21 INFO - Running post-action listener: _resource_record_post_action 10:06:21 INFO - [mozharness: 2016-08-19 17:06:21.446732Z] Finished populate-webroot step (success) 10:06:21 INFO - [mozharness: 2016-08-19 17:06:21.446880Z] Running create-virtualenv step. 10:06:21 INFO - Running pre-action listener: _resource_record_pre_action 10:06:21 INFO - Running main action method: create_virtualenv 10:06:21 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:21 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 10:06:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:21 INFO - Using real prefix '/tools/python27' 10:06:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:22 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:25 INFO - Installing pip.................done. 10:06:25 INFO - Return code: 0 10:06:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:25 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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:25 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 10:06:25 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 10:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:25 INFO - 'HOME': '/Users/cltbld', 10:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:25 INFO - 'LOGNAME': 'cltbld', 10:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:25 INFO - 'MOZ_NO_REMOTE': '1', 10:06:25 INFO - 'NO_EM_RESTART': '1', 10:06:25 INFO - 'PAGER': '/bin/cat', 10:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:25 INFO - 'PWD': '/builds/slave/test', 10:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:25 INFO - 'SHELL': '/bin/bash', 10:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:25 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:25 INFO - 'USER': 'cltbld', 10:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:25 INFO - 'XPC_FLAGS': '0x0', 10:06:25 INFO - 'XPC_SERVICE_NAME': '0', 10:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:25 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 10:06:25 INFO - Cleaning up... 10:06:25 INFO - Return code: 0 10:06:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:25 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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:25 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 10:06:25 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 10:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:25 INFO - 'HOME': '/Users/cltbld', 10:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:25 INFO - 'LOGNAME': 'cltbld', 10:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:25 INFO - 'MOZ_NO_REMOTE': '1', 10:06:25 INFO - 'NO_EM_RESTART': '1', 10:06:25 INFO - 'PAGER': '/bin/cat', 10:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:25 INFO - 'PWD': '/builds/slave/test', 10:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:25 INFO - 'SHELL': '/bin/bash', 10:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:25 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:25 INFO - 'USER': 'cltbld', 10:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:25 INFO - 'XPC_FLAGS': '0x0', 10:06:25 INFO - 'XPC_SERVICE_NAME': '0', 10:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:25 INFO - Downloading/unpacking psutil>=3.1.1 10:06:25 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 10:06:25 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 10:06:25 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 10:06:25 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 10:06:25 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 10:06:25 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 10:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:29 INFO - Installing collected packages: psutil 10:06:29 INFO - Running setup.py install for psutil 10:06:29 INFO - building 'psutil._psutil_osx' extension 10:06:29 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 10:06:29 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 10:06:29 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 10:06:30 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 10:06:30 INFO - building 'psutil._psutil_posix' extension 10:06:30 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 10:06:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:06:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:06:30 INFO - ^ 10:06:30 INFO - 1 warning generated. 10:06:30 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 10:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:30 INFO - Successfully installed psutil 10:06:30 INFO - Cleaning up... 10:06:30 INFO - Return code: 0 10:06:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:06:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:30 INFO - 'HOME': '/Users/cltbld', 10:06:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:30 INFO - 'LOGNAME': 'cltbld', 10:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:30 INFO - 'MOZ_NO_REMOTE': '1', 10:06:30 INFO - 'NO_EM_RESTART': '1', 10:06:30 INFO - 'PAGER': '/bin/cat', 10:06:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:30 INFO - 'PWD': '/builds/slave/test', 10:06:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:30 INFO - 'SHELL': '/bin/bash', 10:06:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:30 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:30 INFO - 'USER': 'cltbld', 10:06:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:30 INFO - 'XPC_FLAGS': '0x0', 10:06:30 INFO - 'XPC_SERVICE_NAME': '0', 10:06:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06:30 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 10:06:30 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 10:06:30 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 10:06:30 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 10:06:30 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 10:06:30 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 10:06:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:33 INFO - Installing collected packages: mozsystemmonitor 10:06:33 INFO - Running setup.py install for mozsystemmonitor 10:06:33 INFO - Successfully installed mozsystemmonitor 10:06:33 INFO - Cleaning up... 10:06:33 INFO - Return code: 0 10:06:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', '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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:06: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 jsonschema==2.5.1 10:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:33 INFO - 'HOME': '/Users/cltbld', 10:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:33 INFO - 'LOGNAME': 'cltbld', 10:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:33 INFO - 'MOZ_NO_REMOTE': '1', 10:06:33 INFO - 'NO_EM_RESTART': '1', 10:06:33 INFO - 'PAGER': '/bin/cat', 10:06:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:33 INFO - 'PWD': '/builds/slave/test', 10:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:33 INFO - 'SHELL': '/bin/bash', 10:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:33 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:33 INFO - 'USER': 'cltbld', 10:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:33 INFO - 'XPC_FLAGS': '0x0', 10:06:33 INFO - 'XPC_SERVICE_NAME': '0', 10:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:33 INFO - Downloading/unpacking jsonschema==2.5.1 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:36 INFO - warning: no files found matching '*.txt' 10:06:36 INFO - no previously-included directories found matching 'build' 10:06:36 INFO - no previously-included directories found matching 'dist' 10:06:36 INFO - no previously-included directories found matching '.git*' 10:06:36 INFO - Installing collected packages: jsonschema, functools32 10:06:36 INFO - Running setup.py install for functools32 10:06:36 INFO - warning: no files found matching '*.txt' 10:06:36 INFO - no previously-included directories found matching 'build' 10:06:36 INFO - no previously-included directories found matching 'dist' 10:06:36 INFO - no previously-included directories found matching '.git*' 10:06:36 INFO - Successfully installed jsonschema functools32 10:06:36 INFO - Cleaning up... 10:06:36 INFO - Return code: 0 10:06:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:06:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:36 INFO - 'HOME': '/Users/cltbld', 10:06:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:36 INFO - 'LOGNAME': 'cltbld', 10:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:36 INFO - 'MOZ_NO_REMOTE': '1', 10:06:36 INFO - 'NO_EM_RESTART': '1', 10:06:36 INFO - 'PAGER': '/bin/cat', 10:06:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:36 INFO - 'PWD': '/builds/slave/test', 10:06:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:36 INFO - 'SHELL': '/bin/bash', 10:06:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:36 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:36 INFO - 'USER': 'cltbld', 10:06:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:36 INFO - 'XPC_FLAGS': '0x0', 10:06:36 INFO - 'XPC_SERVICE_NAME': '0', 10:06:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:37 INFO - Cleaning up... 10:06:37 INFO - Return code: 0 10:06:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:37 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')]} 10:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:37 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')]} 10:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:37 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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:37 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 10:06:37 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 10:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:37 INFO - 'HOME': '/Users/cltbld', 10:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:37 INFO - 'LOGNAME': 'cltbld', 10:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:37 INFO - 'MOZ_NO_REMOTE': '1', 10:06:37 INFO - 'NO_EM_RESTART': '1', 10:06:37 INFO - 'PAGER': '/bin/cat', 10:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:37 INFO - 'PWD': '/builds/slave/test', 10:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:37 INFO - 'SHELL': '/bin/bash', 10:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:37 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:37 INFO - 'USER': 'cltbld', 10:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:37 INFO - 'XPC_FLAGS': '0x0', 10:06:37 INFO - 'XPC_SERVICE_NAME': '0', 10:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:37 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 10:06:37 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 10:06:37 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 10:06:37 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 10:06:37 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 10:06:37 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 10:06:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:41 INFO - Downloading docopt-0.6.1.tar.gz 10:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:41 INFO - Running setup.py install for blobuploader 10:06:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:41 INFO - Running setup.py install for requests 10:06:41 INFO - Running setup.py install for docopt 10:06:41 INFO - Successfully installed blobuploader requests docopt 10:06:41 INFO - Cleaning up... 10:06:42 INFO - Return code: 0 10:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:42 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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:42 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 10:06:42 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 10:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:42 INFO - 'HOME': '/Users/cltbld', 10:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:42 INFO - 'LOGNAME': 'cltbld', 10:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:42 INFO - 'MOZ_NO_REMOTE': '1', 10:06:42 INFO - 'NO_EM_RESTART': '1', 10:06:42 INFO - 'PAGER': '/bin/cat', 10:06:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:42 INFO - 'PWD': '/builds/slave/test', 10:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:42 INFO - 'SHELL': '/bin/bash', 10:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:42 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:42 INFO - 'USER': 'cltbld', 10:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:42 INFO - 'XPC_FLAGS': '0x0', 10:06:42 INFO - 'XPC_SERVICE_NAME': '0', 10:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:42 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Ufx7Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:42 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-DbMiFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:42 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-1uN7Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:42 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-V7K7FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:42 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-xjt8eD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:42 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-VO352B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:42 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-WKKJRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-fImoWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-XPOzDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-sU032W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-c9TuWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Auik8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-pfHu2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-OtyB3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-BK45ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-gPKKR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:43 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-lhPYkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:44 INFO - Running setup.py install for manifestparser 10:06:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:44 INFO - Running setup.py install for mozcrash 10:06:44 INFO - Running setup.py install for mozdebug 10:06:44 INFO - Running setup.py install for mozdevice 10:06:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:44 INFO - Running setup.py install for mozfile 10:06:44 INFO - Running setup.py install for mozhttpd 10:06:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:44 INFO - Running setup.py install for mozinfo 10:06:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Running setup.py install for mozInstall 10:06:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Running setup.py install for mozleak 10:06:45 INFO - Running setup.py install for mozlog 10:06:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Running setup.py install for moznetwork 10:06:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Running setup.py install for mozprocess 10:06:45 INFO - Running setup.py install for mozprofile 10:06:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:45 INFO - Running setup.py install for mozrunner 10:06:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:46 INFO - Running setup.py install for mozscreenshot 10:06:46 INFO - Running setup.py install for moztest 10:06:46 INFO - Running setup.py install for mozversion 10:06:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:46 INFO - Cleaning up... 10:06:46 INFO - Return code: 0 10:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:46 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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:46 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 10:06:46 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 10:06:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:46 INFO - 'HOME': '/Users/cltbld', 10:06:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:46 INFO - 'LOGNAME': 'cltbld', 10:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:46 INFO - 'MOZ_NO_REMOTE': '1', 10:06:46 INFO - 'NO_EM_RESTART': '1', 10:06:46 INFO - 'PAGER': '/bin/cat', 10:06:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:46 INFO - 'PWD': '/builds/slave/test', 10:06:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:46 INFO - 'SHELL': '/bin/bash', 10:06:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:46 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:46 INFO - 'USER': 'cltbld', 10:06:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:46 INFO - 'XPC_FLAGS': '0x0', 10:06:46 INFO - 'XPC_SERVICE_NAME': '0', 10:06:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:46 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ZeHohH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-25I0wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-2inkIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-0JWHub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-_POIjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-UbRxiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-NmbX3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-F__hLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Xg1l3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-nxAG_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:47 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)) 10:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:47 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-BZeYca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:48 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)) 10:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:48 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ITI4k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:48 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)) 10:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:48 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-kvFZz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:48 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)) 10:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:48 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-sIYlR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:48 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)) 10:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:48 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-lsaxz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:48 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)) 10:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:48 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-fCQwVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:48 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)) 10:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:48 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-vx2xfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:48 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)) 10:06:48 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)) 10:06:48 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)) 10:06:48 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)) 10:06:48 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)) 10:06:48 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)) 10:06:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:51 INFO - Downloading blessings-1.6.tar.gz 10:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:51 INFO - Installing collected packages: blessings 10:06:51 INFO - Running setup.py install for blessings 10:06:51 INFO - Successfully installed blessings 10:06:51 INFO - Cleaning up... 10:06:51 INFO - Return code: 0 10:06:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:51 INFO - Reading from file tmpfile_stdout 10:06:51 INFO - Current package versions: 10:06:51 INFO - blessings == 1.6 10:06:51 INFO - blobuploader == 1.2.4 10:06:51 INFO - docopt == 0.6.1 10:06:51 INFO - functools32 == 3.2.3-2 10:06:51 INFO - jsonschema == 2.5.1 10:06:51 INFO - manifestparser == 1.1 10:06:51 INFO - mozInstall == 1.12 10:06:51 INFO - mozcrash == 0.17 10:06:51 INFO - mozdebug == 0.1 10:06:51 INFO - mozdevice == 0.48 10:06:51 INFO - mozfile == 1.2 10:06:51 INFO - mozhttpd == 0.7 10:06:51 INFO - mozinfo == 0.9 10:06:51 INFO - mozleak == 0.1 10:06:51 INFO - mozlog == 3.3 10:06:51 INFO - moznetwork == 0.27 10:06:51 INFO - mozprocess == 0.23 10:06:51 INFO - mozprofile == 0.28 10:06:51 INFO - mozrunner == 6.12 10:06:51 INFO - mozscreenshot == 0.1 10:06:51 INFO - mozsystemmonitor == 0.3 10:06:51 INFO - moztest == 0.7 10:06:51 INFO - mozversion == 1.4 10:06:51 INFO - psutil == 3.1.1 10:06:51 INFO - requests == 1.2.3 10:06:51 INFO - wsgiref == 0.1.2 10:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 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 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:51 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 10:06:51 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 10:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:51 INFO - 'HOME': '/Users/cltbld', 10:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:51 INFO - 'LOGNAME': 'cltbld', 10:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:51 INFO - 'MOZ_NO_REMOTE': '1', 10:06:51 INFO - 'NO_EM_RESTART': '1', 10:06:51 INFO - 'PAGER': '/bin/cat', 10:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:51 INFO - 'PWD': '/builds/slave/test', 10:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:51 INFO - 'SHELL': '/bin/bash', 10:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:51 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:51 INFO - 'USER': 'cltbld', 10:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:51 INFO - 'XPC_FLAGS': '0x0', 10:06:51 INFO - 'XPC_SERVICE_NAME': '0', 10:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 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)) 10:06:51 INFO - Cleaning up... 10:06:52 INFO - Return code: 0 10:06:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a442618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3704d2ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, '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.ceNe9atk3E/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.CxPL6zxGvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 10:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:06:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:52 INFO - 'HOME': '/Users/cltbld', 10:06:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:52 INFO - 'LOGNAME': 'cltbld', 10:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:52 INFO - 'MOZ_NO_REMOTE': '1', 10:06:52 INFO - 'NO_EM_RESTART': '1', 10:06:52 INFO - 'PAGER': '/bin/cat', 10:06:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:52 INFO - 'PWD': '/builds/slave/test', 10:06:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:52 INFO - 'SHELL': '/bin/bash', 10:06:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:06:52 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:06:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:52 INFO - 'USER': 'cltbld', 10:06:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:52 INFO - 'XPC_FLAGS': '0x0', 10:06:52 INFO - 'XPC_SERVICE_NAME': '0', 10:06:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:52 INFO - Cleaning up... 10:06:52 INFO - Return code: 0 10:06:52 INFO - Running post-action listener: _resource_record_post_action 10:06:52 INFO - Running post-action listener: _start_resource_monitoring 10:06:52 INFO - Starting resource monitoring. 10:06:52 INFO - [mozharness: 2016-08-19 17:06:52.302823Z] Finished create-virtualenv step (success) 10:06:52 INFO - [mozharness: 2016-08-19 17:06:52.303861Z] Running install step. 10:06:52 INFO - Running pre-action listener: _resource_record_pre_action 10:06:52 INFO - Running main action method: install 10:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:52 INFO - Reading from file tmpfile_stdout 10:06:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:52 INFO - Reading from file tmpfile_stdout 10:06:52 INFO - Output received: 10:06:52 INFO - Usage: mozinstall [options] installer 10:06:52 INFO - Options: 10:06:52 INFO - -h, --help show this help message and exit 10:06:52 INFO - -d DEST, --destination=DEST 10:06:52 INFO - Directory to install application into. [default: 10:06:52 INFO - "/builds/slave/test"] 10:06:52 INFO - --app=APP Application being installed. [default: firefox] 10:06:52 INFO - mkdir: /builds/slave/test/build/application 10:06:52 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'] 10:06:52 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 10:07:27 INFO - Reading from file tmpfile_stdout 10:07:27 INFO - Output received: 10:07:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:07:27 INFO - Running post-action listener: _resource_record_post_action 10:07:27 INFO - [mozharness: 2016-08-19 17:07:27.328164Z] Finished install step (success) 10:07:27 INFO - [mozharness: 2016-08-19 17:07:27.328298Z] Running run-tests step. 10:07:27 INFO - Running pre-action listener: _resource_record_pre_action 10:07:27 INFO - Running main action method: run_tests 10:07:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:07:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:07:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:07:27 INFO - 2016-08-19 10:07:27.342 screenresolution[1644:8105] starting screenresolution argv=screenresolution get 10:07:27 INFO - 2016-08-19 10:07:27.345 screenresolution[1644:8105] Display 0: 1600x1200x32@60 10:07:27 INFO - 2016-08-19 10:07:27.350 screenresolution[1645:8107] starting screenresolution argv=screenresolution list 10:07:27 INFO - Available Modes on Display 0 10:07:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:07:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:07:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:07:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:07:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:07:27 INFO - Intel Iris: 10:07:27 INFO - Chipset Model: Intel Iris 10:07:27 INFO - Type: GPU 10:07:27 INFO - Bus: Built-In 10:07:27 INFO - VRAM (Dynamic, Max): 1536 MB 10:07:27 INFO - Vendor: Intel (0x8086) 10:07:27 INFO - Device ID: 0x0a2e 10:07:27 INFO - Revision ID: 0x0009 10:07:27 INFO - Displays: 10:07:27 INFO - Display: 10:07:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:07:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:07:27 INFO - Display Serial Number: 1600x1200 60 10:07:27 INFO - Main Display: Yes 10:07:27 INFO - Mirror: Off 10:07:27 INFO - Online: Yes 10:07:27 INFO - Rotation: Supported 10:07:27 INFO - Return code: 0 10:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:27 INFO - Python 2.7.3 10:07:27 INFO - Return code: 0 10:07:27 INFO - grabbing minidump binary from tooltool 10:07:27 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')]} 10:07:27 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 0x10a311d30>, '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 0x10a076db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a309b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:27 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 10:07:27 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 10:07:27 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 10:07:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:27 INFO - Return code: 0 10:07:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:07:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:07:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0284 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:07:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ceNe9atk3E/Render', 10:07:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:27 INFO - 'HOME': '/Users/cltbld', 10:07:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:27 INFO - 'LOGNAME': 'cltbld', 10:07:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:27 INFO - 'MOZ_NO_REMOTE': '1', 10:07:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:27 INFO - 'NO_EM_RESTART': '1', 10:07:27 INFO - 'PAGER': '/bin/cat', 10:07:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:27 INFO - 'PWD': '/builds/slave/test', 10:07:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:27 INFO - 'SHELL': '/bin/bash', 10:07:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxPL6zxGvx/Listeners', 10:07:27 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 10:07:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:27 INFO - 'USER': 'cltbld', 10:07:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:27 INFO - 'XPC_FLAGS': '0x0', 10:07:27 INFO - 'XPC_SERVICE_NAME': '0', 10:07:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:07:27 INFO - mozversion application_buildid: 20160819071321 10:07:27 INFO - mozversion application_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 10:07:27 INFO - mozversion application_display_name: Nightly 10:07:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:27 INFO - mozversion application_name: Firefox 10:07:27 INFO - mozversion application_remotingname: firefox 10:07:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:07:27 INFO - mozversion application_vendor: Mozilla 10:07:27 INFO - mozversion application_version: 51.0a1 10:07:27 INFO - mozversion platform_buildid: 20160819071321 10:07:27 INFO - mozversion platform_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 10:07:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:07:27 INFO - mozversion platform_version: 51.0a1 10:07:27 INFO - using testdate: 1471626447 10:07:27 INFO - actual date: 1471626447 10:07:27 INFO - starting webserver on 'localhost:49267' 10:07:27 INFO - SUITE-START | Running 2 tests 10:07:27 INFO - TEST-START | dromaeo_css 10:07:27 INFO - operating with platform_type : mac_ 10:07:27 INFO - Initialising browser for dromaeo_css test... 10:07:27 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpYVyt3d/profile http://localhost:49267/getInfo.html) 10:07:30 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 10:07:30 INFO - PROCESS | 1655 | colorDepth:24 10:07:30 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 10:07:30 INFO - PROCESS | 1655 | __metrics 10:07:30 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:07:30 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:07:31 INFO - TEST-INFO | 1655: exit 0 10:07:31 INFO - Browser initialized. 10:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:31 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpYVyt3d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:43 INFO - PROCESS | 1658 | RSS: Main: 228323328 10:07:43 INFO - PROCESS | 1658 | 10:08:34 INFO - PROCESS | 1658 | 1471626514825 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] 10:10:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 10:10:46 INFO - PROCESS | 1658 | RSS: Main: 328712192 10:10:46 INFO - PROCESS | 1658 | 10:13:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 10:13:50 INFO - PROCESS | 1658 | RSS: Main: 371924992 10:13:50 INFO - PROCESS | 1658 | 10:16:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 10:16:53 INFO - PROCESS | 1658 | RSS: Main: 343900160 10:16:53 INFO - PROCESS | 1658 | 10:19:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 10:19:56 INFO - PROCESS | 1658 | RSS: Main: 335323136 10:19:56 INFO - PROCESS | 1658 | 10:22:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 10:23:00 INFO - PROCESS | 1658 | RSS: Main: 337182720 10:23:00 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 10:26:04 INFO - PROCESS | 1658 | RSS: Main: 475402240 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | __start_tp_report 10:26:04 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 10:26:04 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 10:26:04 INFO - PROCESS | 1658 | |i|pagename|runs| 10:26:04 INFO - PROCESS | 1658 | |0;dojo.html;3312.205070783012;3334.949975750364;3336.816475093869;3349.9832500837524;3353.3963886500437;5575.219469274305;5625.80309689161;5647.378788333285;5727.570432217584;5741.827745167641;5282.709450980195;5609.691466969315;5650.321961364642;5737.885242295151;5789.2763404574425;5129.2562578426105;5137.871553211162;5213.270142180078;5237.947620523784;5248.973755131219;5298.258243845846;5304.787808487656;5321.201819727034;5334.893302133974;5342.332208473941;5102.285680004802;5140.7172605506685;5148.124818780816;5220.13867711829;5249.86875328116;5097.8215762448135;5184.792608295664;5201.5838732901275;5207;5224.764885580158;5123.052235336438;5142.562882155022;5173.637845350827;5181.870453238662;5191.506806853343;5719.7140142992685;5776.277965254343;5784;5791.102379131242;5802.506786923117;6013.789517366915;6138.508919286446;6178.135061091451;6223.875522489525;6275.24697036354;6221.191245138149;6266.4360207581085;6276.811695649138;6280.968595157041;6296.307406185316;5799.449052340021;5800.9129863052085;5808.680522571215;5822.0684690449325;5828.067509198508;6174.969125154345;6203.534734894901;6280.748770049238;6359.586626869239;6371.044343348442;6120.571559990758;6157.415045570664;6160.784372546939;6182.629042257479;6183.072539119168;6321.399467050623;6324.873502529924;6325.462335701425;6330.240371155491;6340.175777149033;6049.606775559574;6074.939250607437;6124.326324104345;6128.908066379008;6221.47117495018;6159.969200153971;6205.627662340274;6220.377962203744;6224.190855188796;6236.844078898064;4927.162382395001;4958.231474121517;4958.8760280993265;4960.454350021495;4964.429090654621;4364.345348197796;4386.517483076923;4418.381426600278;4436.622887054572;4449.933251001237;5634.915476267859;5725.713714314351;5726.226959360433;5729.369769325371;5740.196372507852;6269.404406581368;6323.810285691437;6340.429361357407;6344.048392741126;6353.809385718436;5520.1167813149705;5547.861303467364;5686.346070201897;5689.857753556112;5702.258706368146;4836.419629644465;5368.489993450616;5420.566354691615;5420.701861397661;5431.185322201702;6318.178636777281;6321.715522801485;6322.209723784527;6322.841928951813;6338.302786693553;6109.84725381869;6191.628502289697;6261.592996455216;6304.401081897213;6345.555811093179;6310.463610592968;6320.778772742932;6322.968385158045;6323.747050117944;6328.303886572566;6077.331493535619;6149.292831324276;6157.138000679819;6175.382461753788;6200.689965501797;6066.4540191382985;6187.84530386744;6246.46905013079;6264.68676566179;6267.843303917439;6064.211652485149;6103.481204097701;6103.572749907464;6128.172696686069;6136.110264011604;6065;6068.241469816273;6069.119977603311;6075.635461872302;6080.3615620361;5758.107493338539;5801.970990145022;5872.412758724094;5907.3501914790195;5931.169636250842;5903.085021821625;5994.970025149846;6131.356207598138;6140.8771824564155;6150.35421280777;5844.736986835517;5896.351401345934;5908.350081490947;5926.288845338415;5933.525317974638 10:26:04 INFO - PROCESS | 1658 | |1;ext.html;492.8890999525105;506.9949300506994;518.0700642346986;526.812981391606;530.4615814947828;40075.79962100189;41576.75269741905;41610.79194604026;43792.562074379246;43990;42706.93232669185;42934.785326073325;42976.57023429765;43145.35281970773;43161;8790.86813697795;9707.369021013628;9884.555195016206;9889.950550247238;9894.109530142287;8795.736127916172;11916.940415297955;12188.451519681592;12199.634010979686;12399.628011159679;12123.454444550016;12174.269543827399;12189.756204875897;12196.878031219663;12199.390030498484;9920.45437500937;12014.519419223221;12073.818892716616;12156.088293378032;12293.692657683629;11867.109966752529;11917.463714132798;11925.701857453547;11939.880601193963;11944.641660750105;40010;40087.7995610023;40137.197256054715;40189.59810401888;40319.7984010081;3272.1528134234936;3279.7868138570916;3523.2425028618713;3536.6286539913194;3607.206414588786;30660.080197594107;30887.073387798402;31644.683553164403;31993.52009719856;33184.004479865645;2973.2864112613033;3024.5311976643657;3061.7091376319213;3089.7682673799554;3093.9381212375624;535950;542926.2853685706;543775;545081;546552;31961;59111.11333330003;59461;59532.70233648804;59612.70193649004;33124;33336.666633333356;34798.47802282968;35062.47406288908;35168.47247291293;13429.731405371838;14685.77971330431;14689.118652880648;14695.706085878222;14720.263986800617;9731.708048758548;11344.20590558653;11493.655190344303;12494.50021999128;12616.747665046647;7334.413246940232;7445.590492522963;7526.962365188139;7770.494917830323;7779.260970207822;2817.7323154300307;3043.786934914535;3066.1414803854955;3260.1523603863166;3280.5735254416772;873.6461732998146;902.7246689759686;989.747614358334;1012.1801340913884;1022.0597050713361;29048.41903161925;29979.303932252802;30118;30631.38737225243;30930.226744331572;1009.4649835587151;1093.5516438260433;1095.7917995580815;1138.4592318648577;1151.8099513580332;12606.936965315115;15578.065316080845;15627.453039143575;15783.131927744083;16068.517944461684;716087;726205;727539;727745;728129.0780638295;57480;58022.7098864503;58072.4192758067;58085.70957145187;58100.70949645309;1253.147859455579;1288.3171918883006;1291.4382243724199;1379.7306478040227;1405.3605609447677;21789.782102178775;23668.52662946766;28704.425911481234;32169.839150804095;32616;52656.47343526669;53349;53387;53396.4660353407;53467.6633084176;624933;630765.8461707846;633069;633075;633793;26159.084432044787;26530.204093877215;26716.332091697863;26868.46263074767;27196.592051118852;47084.29373559331;47404.52595474001;47549;48289.75855120702;48503.27245091256;38592;38840.8347749568;39052.80473597614;40103;40144.397834033094;38069.61930380772;38344.6165538341;38557.036074098374;39653.80173099116;39858.800705996284;37522.624773751915;38486.42270366003;38963.41554876622;38995;39156.02109947274;31872.840635796674;33531.4970275451;34631.787887423816;34768.30463390667;34786;20799.584008320053;22525.774742252368;25492.85282162344;25788.871055644602;25992 10:26:04 INFO - PROCESS | 1658 | |2;jquery.html;347.57248584241364;362.76782858970256;364.2042137928626;368.9022409061598;394.93088709475853;15168.317425715855;15543.455979040737;20751.481212969644;20912.163513459443;21538.56922861542;11919.76160476792;14453.132812031285;20013.499662508446;20584.485387865312;20808.89595552024;5389.9191512127345;5612.102063669814;5617.9719101404435;5628.887422251552;5628.98678237917;5068;5516.117421212607;6157.846053848645;6246.968765156168;6291.748330066815;6205.7517699291975;6232.626042437446;6232.813015609517;6242.812715618538;6251.749930002795;6785.457163426914;6830.487713421513;6863.14210723662;6864.725410983555;6870.175578930561;5807.419258074159;5985.820425387245;6048.848778780522;6051.334353221142;6076.240469941257;13538.390772415167;13576;13605.863941360558;13694.657633559142;13710.52013179534;2233.687283780272;2313.745487996319;2393.820463465247;2427.781499665021;2937.6327959005125;9898.802023959552;9974.601015959426;10545.420001899893;10610.57557697699;10648.361098334124;1898.3450709505198;1951.31703903634;1961.3135402609116;1963.4502339345006;2074.4917495213767;122753;129650;130223.69776302305;134864.999999999;135050.29899402056;9554.187894028946;9756;9942.105210531086;10031.197504199647;10219.386836789816;12362.690932726753;12459;12492.81260781089;12517.374131293398;12522.998160147166;6946.79159625212;8197.4671646344;8284.171582841667;8299.128591497927;8489.74530764078;6492.577982431221;8145.959270203611;8392.496450213006;8470.322374210049;9023.368364214442;3832.3868181090893;3907.4724912137067;3918.1575961167914;3965.3060714375447;3994.400839874042;1913.2251438167286;1951.2195121951333;1952.077203954104;1982.1664959912023;1997.5605366819277;758.3857075768645;905.6558507767006;925.8287216864901;928.5450129436663;939.9718008459757;20842.791572084087;21548.676769848465;21556.89221553882;21641.675374869388;21684.89157554202;914.2183433164681;939.2720641502754;951.191487235844;963.9084286992725;1022.6522982186092;10372.481375931173;10682.586906529872;11048;11052.226344155994;11233.887661123448;547009;571010.1449492809;578588;606512;614953;117330;120733.79266207226;138342;138910;145081;937.7749340158449;940.5344354544408;964.4454438697777;967.2697113679127;968.8062387522383;19031.809681903556;19246.4226073218;19281.710774338117;19366.322178723676;19372.321968731027;54146;55201;55956.72021639866;56100.15849762175;56353.436465636456;78791.81812272705;80832.19167808247;81436;83364;83467;7584.886226706493;7690.538567685957;7930.405219608437;11620.825687614863;11764.647060588197;11609.941950290195;13513.729725405634;13807.723845523235;14396.640083997983;14563.781543276647;11495.367754773568;11778.82331765007;12079.39603019863;12130.090243231616;12187.51249949992;11461.369624670722;11657.358845263592;11818.054555635357;11946.880531194576;12124.211926224767;11806.35065071395;12081.697957551132;12136.089793265364;12248.87751122513;12312.938435308124;12346.81479777786;12397.814032789696;12688.555900543437;12718.745625087631;12796.296203708513;11605.361705106301;11618.88381116178;11893.108016898941;11989.64031079069;12073 10:26:04 INFO - PROCESS | 1658 | |3;mootools.html;1382;1554.9144797036163;1578.550113217733;1755.964880702386;1870.869039167258;7745.109312429072;8510.361722870786;8786.648534058646;8788.78028049299;8902.154295341948;8625.266852317545;8711;8723.171298726611;8725.214730674237;8726.1710137537;2369.194473878885;2397.928062158138;2402.5074859653814;2403.267003563912;2403.795677367426;2343.121329501437;2375.4298968247667;2392.4856155926473;2393.413613664655;2393.413613664655;2350.612148995414;2368.7039120109985;2385.6421536769535;2391.270662447953;2393.7606239376096;2336.556054349668;2361.327021798788;2365.6333268343433;2373.062640257106;2384.2966324934187;2320.454693147109;2344.6951896253377;2345.2377977157494;2351.1183306260154;2356.2577787996897;8583.313334933191;8658.913410865936;8722.476651400937;8772.868406973901;8821.073787252375;5186.662866913676;5386.676799392049;5387.326584176978;5392.649477783971;5406.756695948652;3079.938401231963;3571.232185080194;3583.3549961007006;3639.2175682228185;3643.453481977698;1100.9009189173014;1109.362116782853;1110.8889111088906;1125.5779082843933;1128.8758236593967;11486.368249746261;11569;11613.1290153238;11625.59310424131;11648.708782280512;4346.130773845243;4430.867073987785;4601.976990115028;4611.746353950565;4630.83792067276;9032.548372581476;9034.412763170372;9048.276137908952;9048.918748687838;9050.411723237969;5172.301739265226;5175.378954525481;5177.8446646599905;5179.456157103526;5181.4041385240425;4195.685323600742;4281.550437204111;4351.695381323277;4512.435945506812;4834.395700537433;3404.727621790251;3713.9071523212137;3781.2248489059675;3838.2131663009573;3848.422736589534;1122.764219513895;1126.5099681638349;1145.3185354713933;1179.7404570994368;1201.0991756182864;896.7354630384052;918.3815765882403;933.5425641435647;934.3693007220099;949.4777872170279;5716.171155182558;5869.090291004901;5944.554158438134;6125.754969801247;6142.846428839225;428.74918172869224;452.9297958816389;458;458.27134855579123;465.43914582927493;3798.9810050950123;3803.980980095082;3988.8603898863403;3992.48097747291;3997.84008639657;10455.529501172465;10481.475926203659;10878;10919.781604367869;10933.726656833484;10728.517216725266;10870.565177392973;10870.673879783619;10877.728056798644;10881.619143329945;6475.377472123798;7532.698692052366;7956.761297161094;8169.142240064826;8266.545340006238;5934.970325148347;5951.256092988377;5967.91048134287;5979.701014949323;6094.7257373417415;9804.460754658563;10117.19062475015;10144.087032167141;10152.543135559064;10173.28786984904;7839.764807055797;9289.62841486333;10014.048665376778;10015.799684006424;10161.441120738134;7001.894971575329;7352.742654007084;7504.174540800616;7597.088349397886;7599.316061554487;8151.470154439942;8156.959215204123;8158.592070396575;8251.092379838334;8296.626651800563;6571.967140164268;7493.138289096605;7500.587467689329;7565.356944659766;7567.810804729926;6260.28006779208;7274;7354.558726476428;7371.447141464519;7446.925530744623;6987.7204911802955;7087.255838136922;7087.645617719197;7092.9645351772915;7110.39561637246;4889.095517329305;4897.8285759998225;4971.925421118758;5058.797648094035;5184.170532714747;5162.97418512905;5191.117510023229;5261.3686357637325;5435.673859568438;5485.341758988947 10:26:04 INFO - PROCESS | 1658 | |4;prototype.html;266.6387045553275;310.58691939720177;313.74900079936043;315.10038839114316;316.90017644441986;4645.976770116153;5284.31303930489;5304.787808487666;5307.65500242484;5352.518273355392;4749.90500189996;5046.84859454217;5231.293775340328;5245.291885595453;5247.317848679666;3785.31864264433;3808.638179372955;3959.4258832469272;4032.919341613166;4088.8773336799795;3245.529398237254;3659.0361806936335;4012.71910966231;4019.3167161582455;4061.451704019949;3608.368535506289;3653.1962968146963;3898.8830335089992;3968.325384684596;3971.8212680429306;3666.9633303666888;3725.926110958443;3994.8202330895033;4023.9537720192666;4028.4964379452567;3421.2722575099665;3466.9479957800654;3508.122969257686;3516.82415879205;3540.1945008045823;4285.657147428198;4364.650827933758;5034.993001399735;5063.949360506384;5117.974410127963;3911.8630847920185;4202;4557.95442045582;4572.1424109931295;4590.563896429834;5289.206619007141;5471.50756431919;5483.616146869721;5492.697901615409;5509.851158048365;3615.94576081359;3643.653852883972;3665.7433979621437;3780.432935059763;3828.1195325075387;4925.2858335541505;5218.712970786643;5430.321209848769;5781.335146458169;5791.362950075489;3406.846691898821;3773.2831561639387;3791.9241615167543;3835.9232815343535;3840.2127563849344;3851.3837785954674;3858.2090671412293;3880.5537363203593;3884.786336751449;3896.2207558488417;4324.481062272547;4533.637309015271;4538.72767633943;4556.65825063115;4564.84023059198;4744.7627618618935;4858.368412106403;5188.948110518922;5512.283403157564;5547.446714919748;1112.3048094940661;1325.7149712811793;1329.6609364612154;1333.2467156056796;1339.5579458778775;776.4060493722307;807.6028470745642;814.1532805881935;819.3404309530765;822.7120507822334;4921.999999999928;5037.269595908573;5063.025420086169;5137.33214682089;5140.537351638296;5401.108817045222;5673.6028478006965;5683.715814209273;5687.1753595729215;5688.914666280009;4198.1393814268;5126.282320475137;5144.768485418165;5147.742612869341;5196.32447781786;2913.621229240185;2973.988843793121;2979.2998645318335;2983.746381557592;2985.671576126624;4990.3032968790785;5164.8192313268855;5552.641176676289;5670.177824215466;5826.70866456684;4520.9095818084115;5288.735563221823;5779.306483221956;5781.942180578225;5871.706414679335;5346.812861549827;5504.788946431779;5645.379008309001;5832.708364581754;5915.615484993462;4533.682642215013;5718.083777273703;5721.971390143022;5738.581292404909;5754.4533269339345;4455.658256307769;5614.775408983595;5614.803481878114;5664.858378540404;5701.7149142541875;4463.553644635511;5235.973820130875;5359.14253719403;5889.911651325147;5970.940290597038;3762.3792074307435;3835.4438606402473;3981.402789581586;4007.499062617173;4008.659263962596;4743.596794272526;5098.566621837037;5204.7918083276245;5310.389305229948;5671.744771485375;4721.811127554859;5484;5509.944900550943;5549.250851135206;5553;5169.604206864051;5407.675539467645;5500.917486237629;5528.889422211614;5553.362152977304;4721.244600863845;5407.486288802557;5421.7560209791445;5442.891142177214;5505.559555235652;4473.175435003026;4637.60580350674;5227.001343971789;5483.369412517452;5573.832785016456;5399.217113518596;5400.378956419905;5439.449756819287;5441.700706461024;5460.699661518495 10:26:04 INFO - PROCESS | 1658 | |5;yui.html;729.3873146556892;748.535907737203;754.724525548175;789.6209819286743;832.7127141136306;15839.683206335882;16611.41860034899;16636;16655.66688666226;16658.916705416457;14774.778378324334;15035;15039.323230454629;15112.47106351278;15122.24388780562;694.6144889586277;711.3384552366298;841.3395484544649;856.1908995998783;883.5449743382163;862.995685021574;875.3784812782932;876.1019954546578;877.6182360673096;885.3536918049828;931.2689538712112;931.8136372725448;933.5099072986668;934.6822080492631;934.7055677461611;931.0782325497776;931.3992474853716;932.3054324528202;933.1321870660283;933.1788026536672;547.1956224350199;575.4446958684847;670.1924181361447;692.4079911675495;693.7814588404636;14916.776248356284;14957.177355245458;14964.551063468005;14972;14978.325975331027;13855.515056972958;14318.785218221736;14355.138691678532;14400.855991440056;14417.423303067864;12942.352882355844;13153.473861045546;13171;13342.533011344653;13521.729565408637;4693.296005599153;4702.27114797207;4880.389951256093;4894.657373983787;4903.607711383081;119124;121085;128458;129591.35204323918;130932.34533827365;11004.284721493077;11275.774484510264;11398.658040258806;11531.538738450536;11829.093417089693;22711.659325110137;22806.65790013151;22812.65781013286;22822.087116515486;22887.771122288897;7158.105236845395;8069.919300806917;8078.43450958439;8099.856321839038;8164.224398682116;4483.910321793546;4529.501754806968;4557.908841823145;4718.268668356411;4728.361671174347;3461.9134521636656;3574.5531808523933;3576.91057723559;3579.087332730137;3588.372034893883;648.8669822686338;650.440621065883;658.5916731626422;677.5697432130632;678.6064082831946;553.9695316757617;566.9801556945487;621.9440250377488;630.3129588748286;636.1094467745194;7339.449541284425;8801.119888011148;8922.973858006413;8944.418612790148;9128.771780705403;542.8697112692926;551.9061759500895;559.4293820303268;589.8945909833192;640.897456406982;4227.957720422818;4387.714798538085;4395.626371758372;4453.821847126079;4474.172278128557;147774.52225477822;148765;168694.75662920528;170501;172742;110806.59514263095;123307.53384932251;127921.36039319744;129982;131832;79262.6036869812;97391.99999999859;97523.51238243905;106624;118184;9310.348275620641;9471.431714097176;9628.374155679858;9987.700368988651;10032.147267482345;63454.68272658792;63493;64581.03128452983;66399.33600664124;66516.6674166626;84510;89814.55092724494;94923.52538237265;96513.03486965041;98165;12625.87374126247;13157.27634980047;13233.691577105723;13414.597562073153;13532.93233533826;10675;14966.476173333882;15032.24838758036;15131.848681513044;15491.07053576789;10654.573817047542;13113.475460981454;13827.792583111463;13884.652883677585;13966.650833729238;13202.075854690464;13766.724665506434;13851.099678520864;14049.719005619625;14155.575332740034;13555.525556605471;13586.184828910296;13687.726245475234;13981.370838312097;14117.505887294306;10864.619738309122;10917.781644367227;11302.265352752045;11449.542018319175;11529.308241505536;10908.945455272673;10934.453277335942;10936.179786516203;11371.54513819438;11454.140939429743 10:26:04 INFO - PROCESS | 1658 | __end_tp_report 10:26:04 INFO - PROCESS | 1658 | __start_cc_report 10:26:04 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1315 10:26:04 INFO - PROCESS | 1658 | __end_cc_report 10:26:04 INFO - PROCESS | 1658 | __startTimestamp1471627564306__endTimestamp 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | ------- Summary: start ------- 10:26:04 INFO - PROCESS | 1658 | Number of tests: 6 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5737.50 Median:5908.35 stddev:645.89 (10.9%) stddev-sans-first:619.22 10:26:04 INFO - PROCESS | 1658 | Values: 3312.2 3334.9 3336.8 3350.0 3353.4 5575.2 5625.8 5647.4 5727.6 5741.8 5282.7 5609.7 5650.3 5737.9 5789.3 5129.3 5137.9 5213.3 5237.9 5249.0 5298.3 5304.8 5321.2 5334.9 5342.3 5102.3 5140.7 5148.1 5220.1 5249.9 5097.8 5184.8 5201.6 5207.0 5224.8 5123.1 5142.6 5173.6 5181.9 5191.5 5719.7 5776.3 5784.0 5791.1 5802.5 6013.8 6138.5 6178.1 6223.9 6275.2 6221.2 6266.4 6276.8 6281.0 6296.3 5799.4 5800.9 5808.7 5822.1 5828.1 6175.0 6203.5 6280.7 6359.6 6371.0 6120.6 6157.4 6160.8 6182.6 6183.1 6321.4 6324.9 6325.5 6330.2 6340.2 6049.6 6074.9 6124.3 6128.9 6221.5 6160.0 6205.6 6220.4 6224.2 6236.8 4927.2 4958.2 4958.9 4960.5 4964.4 4364.3 4386.5 4418.4 4436.6 4449.9 5634.9 5725.7 5726.2 5729.4 5740.2 6269.4 6323.8 6340.4 6344.0 6353.8 5520.1 5547.9 5686.3 5689.9 5702.3 4836.4 5368.5 5420.6 5420.7 5431.2 6318.2 6321.7 6322.2 6322.8 6338.3 6109.8 6191.6 6261.6 6304.4 6345.6 6310.5 6320.8 6323.0 6323.7 6328.3 6077.3 6149.3 6157.1 6175.4 6200.7 6066.5 6187.8 6246.5 6264.7 6267.8 6064.2 6103.5 6103.6 6128.2 6136.1 6065.0 6068.2 6069.1 6075.6 6080.4 5758.1 5802.0 5872.4 5907.4 5931.2 5903.1 5995.0 6131.4 6140.9 6150.4 5844.7 5896.4 5908.4 5926.3 5933.5 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:74499.02 Median:35115.47 stddev:171099.19 (487.2%) stddev-sans-first:171488.94 10:26:04 INFO - PROCESS | 1658 | Values: 492.9 507.0 518.1 526.8 530.5 40075.8 41576.8 41610.8 43792.6 43990.0 42706.9 42934.8 42976.6 43145.4 43161.0 8790.9 9707.4 9884.6 9890.0 9894.1 8795.7 11916.9 12188.5 12199.6 12399.6 12123.5 12174.3 12189.8 12196.9 12199.4 9920.5 12014.5 12073.8 12156.1 12293.7 11867.1 11917.5 11925.7 11939.9 11944.6 40010.0 40087.8 40137.2 40189.6 40319.8 3272.2 3279.8 3523.2 3536.6 3607.2 30660.1 30887.1 31644.7 31993.5 33184.0 2973.3 3024.5 3061.7 3089.8 3093.9 535950.0 542926.3 543775.0 545081.0 546552.0 31961.0 59111.1 59461.0 59532.7 59612.7 33124.0 33336.7 34798.5 35062.5 35168.5 13429.7 14685.8 14689.1 14695.7 14720.3 9731.7 11344.2 11493.7 12494.5 12616.7 7334.4 7445.6 7527.0 7770.5 7779.3 2817.7 3043.8 3066.1 3260.2 3280.6 873.6 902.7 989.7 1012.2 1022.1 29048.4 29979.3 30118.0 30631.4 30930.2 1009.5 1093.6 1095.8 1138.5 1151.8 12606.9 15578.1 15627.5 15783.1 16068.5 716087.0 726205.0 727539.0 727745.0 728129.1 57480.0 58022.7 58072.4 58085.7 58100.7 1253.1 1288.3 1291.4 1379.7 1405.4 21789.8 23668.5 28704.4 32169.8 32616.0 52656.5 53349.0 53387.0 53396.5 53467.7 624933.0 630765.8 633069.0 633075.0 633793.0 26159.1 26530.2 26716.3 26868.5 27196.6 47084.3 47404.5 47549.0 48289.8 48503.3 38592.0 38840.8 39052.8 40103.0 40144.4 38069.6 38344.6 38557.0 39653.8 39858.8 37522.6 38486.4 38963.4 38995.0 39156.0 31872.8 33531.5 34631.8 34768.3 34786.0 20799.6 22525.8 25492.9 25788.9 25992.0 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35025.22 Median:21599.28 stddev:98159.48 (454.5%) stddev-sans-first:98400.31 10:26:04 INFO - PROCESS | 1658 | Values: 347.6 362.8 364.2 368.9 394.9 15168.3 15543.5 20751.5 20912.2 21538.6 11919.8 14453.1 20013.5 20584.5 20808.9 5389.9 5612.1 5618.0 5628.9 5629.0 5068.0 5516.1 6157.8 6247.0 6291.7 6205.8 6232.6 6232.8 6242.8 6251.7 6785.5 6830.5 6863.1 6864.7 6870.2 5807.4 5985.8 6048.8 6051.3 6076.2 13538.4 13576.0 13605.9 13694.7 13710.5 2233.7 2313.7 2393.8 2427.8 2937.6 9898.8 9974.6 10545.4 10610.6 10648.4 1898.3 1951.3 1961.3 1963.5 2074.5 122753.0 129650.0 130223.7 134865.0 135050.3 9554.2 9756.0 9942.1 10031.2 10219.4 12362.7 12459.0 12492.8 12517.4 12523.0 6946.8 8197.5 8284.2 8299.1 8489.7 6492.6 8146.0 8392.5 8470.3 9023.4 3832.4 3907.5 3918.2 3965.3 3994.4 1913.2 1951.2 1952.1 1982.2 1997.6 758.4 905.7 925.8 928.5 940.0 20842.8 21548.7 21556.9 21641.7 21684.9 914.2 939.3 951.2 963.9 1022.7 10372.5 10682.6 11048.0 11052.2 11233.9 547009.0 571010.1 578588.0 606512.0 614953.0 117330.0 120733.8 138342.0 138910.0 145081.0 937.8 940.5 964.4 967.3 968.8 19031.8 19246.4 19281.7 19366.3 19372.3 54146.0 55201.0 55956.7 56100.2 56353.4 78791.8 80832.2 81436.0 83364.0 83467.0 7584.9 7690.5 7930.4 11620.8 11764.6 11609.9 13513.7 13807.7 14396.6 14563.8 11495.4 11778.8 12079.4 12130.1 12187.5 11461.4 11657.4 11818.1 11946.9 12124.2 11806.4 12081.7 12136.1 12248.9 12312.9 12346.8 12397.8 12688.6 12718.7 12796.3 11605.4 11618.9 11893.1 11989.6 12073.0 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5627.22 Median:2649.92 stddev:3166.27 (119.5%) stddev-sans-first:3159.08 10:26:04 INFO - PROCESS | 1658 | Values: 1382.0 1554.9 1578.6 1756.0 1870.9 7745.1 8510.4 8786.6 8788.8 8902.2 8625.3 8711.0 8723.2 8725.2 8726.2 2369.2 2397.9 2402.5 2403.3 2403.8 2343.1 2375.4 2392.5 2393.4 2393.4 2350.6 2368.7 2385.6 2391.3 2393.8 2336.6 2361.3 2365.6 2373.1 2384.3 2320.5 2344.7 2345.2 2351.1 2356.3 8583.3 8658.9 8722.5 8772.9 8821.1 5186.7 5386.7 5387.3 5392.6 5406.8 3079.9 3571.2 3583.4 3639.2 3643.5 1100.9 1109.4 1110.9 1125.6 1128.9 11486.4 11569.0 11613.1 11625.6 11648.7 4346.1 4430.9 4602.0 4611.7 4630.8 9032.5 9034.4 9048.3 9048.9 9050.4 5172.3 5175.4 5177.8 5179.5 5181.4 4195.7 4281.6 4351.7 4512.4 4834.4 3404.7 3713.9 3781.2 3838.2 3848.4 1122.8 1126.5 1145.3 1179.7 1201.1 896.7 918.4 933.5 934.4 949.5 5716.2 5869.1 5944.6 6125.8 6142.8 428.7 452.9 458.0 458.3 465.4 3799.0 3804.0 3988.9 3992.5 3997.8 10455.5 10481.5 10878.0 10919.8 10933.7 10728.5 10870.6 10870.7 10877.7 10881.6 6475.4 7532.7 7956.8 8169.1 8266.5 5935.0 5951.3 5967.9 5979.7 6094.7 9804.5 10117.2 10144.1 10152.5 10173.3 7839.8 9289.6 10014.0 10015.8 10161.4 7001.9 7352.7 7504.2 7597.1 7599.3 8151.5 8157.0 8158.6 8251.1 8296.6 6572.0 7493.1 7500.6 7565.4 7567.8 6260.3 7274.0 7354.6 7371.4 7446.9 6987.7 7087.3 7087.6 7093.0 7110.4 4889.1 4897.8 4971.9 5058.8 5184.2 5163.0 5191.1 5261.4 5435.7 5485.3 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4438.66 Median:5042.06 stddev:1353.08 (26.8%) stddev-sans-first:1320.15 10:26:04 INFO - PROCESS | 1658 | Values: 266.6 310.6 313.7 315.1 316.9 4646.0 5284.3 5304.8 5307.7 5352.5 4749.9 5046.8 5231.3 5245.3 5247.3 3785.3 3808.6 3959.4 4032.9 4088.9 3245.5 3659.0 4012.7 4019.3 4061.5 3608.4 3653.2 3898.9 3968.3 3971.8 3667.0 3725.9 3994.8 4024.0 4028.5 3421.3 3466.9 3508.1 3516.8 3540.2 4285.7 4364.7 5035.0 5063.9 5118.0 3911.9 4202.0 4558.0 4572.1 4590.6 5289.2 5471.5 5483.6 5492.7 5509.9 3615.9 3643.7 3665.7 3780.4 3828.1 4925.3 5218.7 5430.3 5781.3 5791.4 3406.8 3773.3 3791.9 3835.9 3840.2 3851.4 3858.2 3880.6 3884.8 3896.2 4324.5 4533.6 4538.7 4556.7 4564.8 4744.8 4858.4 5188.9 5512.3 5547.4 1112.3 1325.7 1329.7 1333.2 1339.6 776.4 807.6 814.2 819.3 822.7 4922.0 5037.3 5063.0 5137.3 5140.5 5401.1 5673.6 5683.7 5687.2 5688.9 4198.1 5126.3 5144.8 5147.7 5196.3 2913.6 2974.0 2979.3 2983.7 2985.7 4990.3 5164.8 5552.6 5670.2 5826.7 4520.9 5288.7 5779.3 5781.9 5871.7 5346.8 5504.8 5645.4 5832.7 5915.6 4533.7 5718.1 5722.0 5738.6 5754.5 4455.7 5614.8 5614.8 5664.9 5701.7 4463.6 5236.0 5359.1 5889.9 5970.9 3762.4 3835.4 3981.4 4007.5 4008.7 4743.6 5098.6 5204.8 5310.4 5671.7 4721.8 5484.0 5509.9 5549.3 5553.0 5169.6 5407.7 5500.9 5528.9 5553.4 4721.2 5407.5 5421.8 5442.9 5505.6 4473.2 4637.6 5227.0 5483.4 5573.8 5399.2 5400.4 5439.4 5441.7 5460.7 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:25521.79 Median:3578.00 stddev:41114.80 (1149.1%) stddev-sans-first:41188.00 10:26:04 INFO - PROCESS | 1658 | Values: 729.4 748.5 754.7 789.6 832.7 15839.7 16611.4 16636.0 16655.7 16658.9 14774.8 15035.0 15039.3 15112.5 15122.2 694.6 711.3 841.3 856.2 883.5 863.0 875.4 876.1 877.6 885.4 931.3 931.8 933.5 934.7 934.7 931.1 931.4 932.3 933.1 933.2 547.2 575.4 670.2 692.4 693.8 14916.8 14957.2 14964.6 14972.0 14978.3 13855.5 14318.8 14355.1 14400.9 14417.4 12942.4 13153.5 13171.0 13342.5 13521.7 4693.3 4702.3 4880.4 4894.7 4903.6 119124.0 121085.0 128458.0 129591.4 130932.3 11004.3 11275.8 11398.7 11531.5 11829.1 22711.7 22806.7 22812.7 22822.1 22887.8 7158.1 8069.9 8078.4 8099.9 8164.2 4483.9 4529.5 4557.9 4718.3 4728.4 3461.9 3574.6 3576.9 3579.1 3588.4 648.9 650.4 658.6 677.6 678.6 554.0 567.0 621.9 630.3 636.1 7339.4 8801.1 8923.0 8944.4 9128.8 542.9 551.9 559.4 589.9 640.9 4228.0 4387.7 4395.6 4453.8 4474.2 147774.5 148765.0 168694.8 170501.0 172742.0 110806.6 123307.5 127921.4 129982.0 131832.0 79262.6 97392.0 97523.5 106624.0 118184.0 9310.3 9471.4 9628.4 9987.7 10032.1 63454.7 63493.0 64581.0 66399.3 66516.7 84510.0 89814.6 94923.5 96513.0 98165.0 12625.9 13157.3 13233.7 13414.6 13532.9 10675.0 14966.5 15032.2 15131.8 15491.1 10654.6 13113.5 13827.8 13884.7 13966.7 13202.1 13766.7 13851.1 14049.7 14155.6 13555.5 13586.2 13687.7 13981.4 14117.5 10864.6 10917.8 11302.3 11449.5 11529.3 10908.9 10934.5 10936.2 11371.5 11454.1 10:26:04 INFO - PROCESS | 1658 | -------- Summary: end -------- 10:26:04 INFO - PROCESS | 1658 | 10:26:04 INFO - TEST-INFO | 1658: exit 0 10:26:04 INFO - TEST-OK | dromaeo_css | took 1117010ms 10:26:04 INFO - TEST-START | kraken 10:26:04 INFO - operating with platform_type : mac_ 10:26:04 INFO - Initialising browser for kraken test... 10:26:04 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmp7vUmm4/profile http://localhost:49267/getInfo.html) 10:26:07 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 10:26:07 INFO - PROCESS | 1664 | colorDepth:24 10:26:07 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 10:26:07 INFO - PROCESS | 1664 | __metrics 10:26:07 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:26:07 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:07 INFO - TEST-INFO | 1664: exit 0 10:26:07 INFO - Browser initialized. 10:26:07 INFO - Running cycle 1/1 for kraken test... 10:26:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmp7vUmm4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:19 INFO - PROCESS | 1665 | RSS: Main: 228581376 10:26:19 INFO - PROCESS | 1665 | 10:26:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:23 INFO - PROCESS | 1665 | RSS: Main: 292630528 10:26:23 INFO - PROCESS | 1665 | 10:26:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 10:26:26 INFO - PROCESS | 1665 | RSS: Main: 288710656 10:26:26 INFO - PROCESS | 1665 | 10:26:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 10:26:30 INFO - PROCESS | 1665 | RSS: Main: 379637760 10:26:30 INFO - PROCESS | 1665 | 10:26:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 10:26:33 INFO - PROCESS | 1665 | RSS: Main: 281935872 10:26:33 INFO - PROCESS | 1665 | 10:26:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:36 INFO - PROCESS | 1665 | RSS: Main: 287490048 10:26:36 INFO - PROCESS | 1665 | 10:26:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:39 INFO - PROCESS | 1665 | RSS: Main: 324902912 10:26:39 INFO - PROCESS | 1665 | 10:26:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:42 INFO - PROCESS | 1665 | RSS: Main: 325844992 10:26:42 INFO - PROCESS | 1665 | 10:26:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 10:26:46 INFO - PROCESS | 1665 | RSS: Main: 327090176 10:26:46 INFO - PROCESS | 1665 | 10:26:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:48 INFO - PROCESS | 1665 | RSS: Main: 300679168 10:26:48 INFO - PROCESS | 1665 | 10:26:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:51 INFO - PROCESS | 1665 | RSS: Main: 305078272 10:26:51 INFO - PROCESS | 1665 | 10:26:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:54 INFO - PROCESS | 1665 | RSS: Main: 305049600 10:26:54 INFO - PROCESS | 1665 | 10:26:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:57 INFO - PROCESS | 1665 | RSS: Main: 314163200 10:26:57 INFO - PROCESS | 1665 | 10:27:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:01 INFO - PROCESS | 1665 | RSS: Main: 315383808 10:27:01 INFO - PROCESS | 1665 | 10:27:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 10:27:03 INFO - PROCESS | 1665 | RSS: Main: 359055360 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | __start_tp_report 10:27:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 10:27:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 10:27:03 INFO - PROCESS | 1665 | |i|pagename|runs| 10:27:03 INFO - PROCESS | 1665 | |0;ai-astar;101;112;112;113;112;114;112;113;112;112 10:27:03 INFO - PROCESS | 1665 | |1;audio-beat-detection;140;107;113;151;138;138;134;102;156;106 10:27:03 INFO - PROCESS | 1665 | |2;audio-dft;181;184;185;182;184;178;183;183;183;183 10:27:03 INFO - PROCESS | 1665 | |3;audio-fft;74;79;48;86;74;81;83;82;84;57 10:27:03 INFO - PROCESS | 1665 | |4;audio-oscillator;83;69;105;72;75;68;95;71;67;103 10:27:03 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;88;86;89;87;89;86;90;87;90;85 10:27:03 INFO - PROCESS | 1665 | |6;imaging-darkroom;94;94;93;95;94;94;94;95;95;94 10:27:03 INFO - PROCESS | 1665 | |7;imaging-desaturate;84;103;130;134;85;86;101;131;139;84 10:27:03 INFO - PROCESS | 1665 | |8;json-parse-financial;54;55;53;54;52;56;54;53;54;52 10:27:03 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;65;68;76;73;71;67;66;68;68;69 10:27:03 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;85;83;84;84;88;87;82;83;84;86 10:27:03 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;139;137;134;127;136;136;132;140;158;144 10:27:03 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;169;169;169;167;168;168;167;186;230;190 10:27:03 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;67;68;67;66;67;66;66;67;67 10:27:03 INFO - PROCESS | 1665 | __end_tp_report 10:27:03 INFO - PROCESS | 1665 | __start_cc_report 10:27:03 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2051 10:27:03 INFO - PROCESS | 1665 | __end_cc_report 10:27:03 INFO - PROCESS | 1665 | __startTimestamp1471627623244__endTimestamp 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | ------- Summary: start ------- 10:27:03 INFO - PROCESS | 1665 | Number of tests: 14 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.68 (3.3%) stddev-sans-first:0.73 10:27:03 INFO - PROCESS | 1665 | Values: 101.0 112.0 112.0 113.0 112.0 114.0 112.0 113.0 112.0 112.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:138.00 stddev:19.77 (14.3%) stddev-sans-first:20.52 10:27:03 INFO - PROCESS | 1665 | Values: 140.0 107.0 113.0 151.0 138.0 138.0 134.0 102.0 156.0 106.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.96 (1.1%) stddev-sans-first:1.99 10:27:03 INFO - PROCESS | 1665 | Values: 181.0 184.0 185.0 182.0 184.0 178.0 183.0 183.0 183.0 183.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:74.80 Median:81.50 stddev:12.57 (15.4%) stddev-sans-first:13.33 10:27:03 INFO - PROCESS | 1665 | Values: 74.0 79.0 48.0 86.0 74.0 81.0 83.0 82.0 84.0 57.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:71.50 stddev:14.85 (20.8%) stddev-sans-first:15.73 10:27:03 INFO - PROCESS | 1665 | Values: 83.0 69.0 105.0 72.0 75.0 68.0 95.0 71.0 67.0 103.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.50 stddev:1.77 (2.0%) stddev-sans-first:1.87 10:27:03 INFO - PROCESS | 1665 | Values: 88.0 86.0 89.0 87.0 89.0 86.0 90.0 87.0 90.0 85.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:27:03 INFO - PROCESS | 1665 | Values: 94.0 94.0 93.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:111.50 stddev:23.30 (20.9%) stddev-sans-first:23.09 10:27:03 INFO - PROCESS | 1665 | Values: 84.0 103.0 130.0 134.0 85.0 86.0 101.0 131.0 139.0 84.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.25 (2.3%) stddev-sans-first:1.32 10:27:03 INFO - PROCESS | 1665 | Values: 54.0 55.0 53.0 54.0 52.0 56.0 54.0 53.0 54.0 52.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.50 stddev:3.35 (4.9%) stddev-sans-first:3.21 10:27:03 INFO - PROCESS | 1665 | Values: 65.0 68.0 76.0 73.0 71.0 67.0 66.0 68.0 68.0 69.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:1.90 (2.2%) stddev-sans-first:2.01 10:27:03 INFO - PROCESS | 1665 | Values: 85.0 83.0 84.0 84.0 88.0 87.0 82.0 83.0 84.0 86.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:138.00 stddev:8.31 (6.0%) stddev-sans-first:8.81 10:27:03 INFO - PROCESS | 1665 | Values: 139.0 137.0 134.0 127.0 136.0 136.0 132.0 140.0 158.0 144.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:169.00 stddev:19.99 (11.8%) stddev-sans-first:20.92 10:27:03 INFO - PROCESS | 1665 | Values: 169.0 169.0 169.0 167.0 168.0 168.0 167.0 186.0 230.0 190.0 10:27:03 INFO - PROCESS | 1665 | 10:27:03 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 10:27:03 INFO - PROCESS | 1665 | Values: 67.0 67.0 68.0 67.0 66.0 67.0 66.0 66.0 67.0 67.0 10:27:03 INFO - PROCESS | 1665 | -------- Summary: end -------- 10:27:03 INFO - PROCESS | 1665 | 10:27:04 INFO - TEST-INFO | 1665: exit 0 10:27:04 INFO - TEST-OK | kraken | took 59136ms 10:27:04 INFO - SUITE-END | took 1176s 10:27:04 INFO - Completed test suite (00:19:36) 10:27:04 INFO - javascript benchmark 10:27:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.205070783012, 3334.949975750364, 3336.816475093869, 3349.9832500837524, 3353.3963886500437, 5575.219469274305, 5625.80309689161, 5647.378788333285, 5727.570432217584, 5741.827745167641, 5282.709450980195, 5609.691466969315, 5650.321961364642, 5737.885242295151, 5789.2763404574425, 5129.2562578426105, 5137.871553211162, 5213.270142180078, 5237.947620523784, 5248.973755131219, 5298.258243845846, 5304.787808487656, 5321.201819727034, 5334.893302133974, 5342.332208473941, 5102.285680004802, 5140.7172605506685, 5148.124818780816, 5220.13867711829, 5249.86875328116, 5097.8215762448135, 5184.792608295664, 5201.5838732901275, 5207.0, 5224.764885580158, 5123.052235336438, 5142.562882155022, 5173.637845350827, 5181.870453238662, 5191.506806853343, 5719.7140142992685, 5776.277965254343, 5784.0, 5791.102379131242, 5802.506786923117, 6013.789517366915, 6138.508919286446, 6178.135061091451, 6223.875522489525, 6275.24697036354, 6221.191245138149, 6266.4360207581085, 6276.811695649138, 6280.968595157041, 6296.307406185316, 5799.449052340021, 5800.9129863052085, 5808.680522571215, 5822.0684690449325, 5828.067509198508, 6174.969125154345, 6203.534734894901, 6280.748770049238, 6359.586626869239, 6371.044343348442, 6120.571559990758, 6157.415045570664, 6160.784372546939, 6182.629042257479, 6183.072539119168, 6321.399467050623, 6324.873502529924, 6325.462335701425, 6330.240371155491, 6340.175777149033, 6049.606775559574, 6074.939250607437, 6124.326324104345, 6128.908066379008, 6221.47117495018, 6159.969200153971, 6205.627662340274, 6220.377962203744, 6224.190855188796, 6236.844078898064, 4927.162382395001, 4958.231474121517, 4958.8760280993265, 4960.454350021495, 4964.429090654621, 4364.345348197796, 4386.517483076923, 4418.381426600278, 4436.622887054572, 4449.933251001237, 5634.915476267859, 5725.713714314351, 5726.226959360433, 5729.369769325371, 5740.196372507852, 6269.404406581368, 6323.810285691437, 6340.429361357407, 6344.048392741126, 6353.809385718436, 5520.1167813149705, 5547.861303467364, 5686.346070201897, 5689.857753556112, 5702.258706368146, 4836.419629644465, 5368.489993450616, 5420.566354691615, 5420.701861397661, 5431.185322201702, 6318.178636777281, 6321.715522801485, 6322.209723784527, 6322.841928951813, 6338.302786693553, 6109.84725381869, 6191.628502289697, 6261.592996455216, 6304.401081897213, 6345.555811093179, 6310.463610592968, 6320.778772742932, 6322.968385158045, 6323.747050117944, 6328.303886572566, 6077.331493535619, 6149.292831324276, 6157.138000679819, 6175.382461753788, 6200.689965501797, 6066.4540191382985, 6187.84530386744, 6246.46905013079, 6264.68676566179, 6267.843303917439, 6064.211652485149, 6103.481204097701, 6103.572749907464, 6128.172696686069, 6136.110264011604, 6065.0, 6068.241469816273, 6069.119977603311, 6075.635461872302, 6080.3615620361, 5758.107493338539, 5801.970990145022, 5872.412758724094, 5907.3501914790195, 5931.169636250842, 5903.085021821625, 5994.970025149846, 6131.356207598138, 6140.8771824564155, 6150.35421280777, 5844.736986835517, 5896.351401345934, 5908.350081490947, 5926.288845338415, 5933.525317974638], "value": 5694.905976226617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8890999525105, 506.9949300506994, 518.0700642346986, 526.812981391606, 530.4615814947828, 40075.79962100189, 41576.75269741905, 41610.79194604026, 43792.562074379246, 43990.0, 42706.93232669185, 42934.785326073325, 42976.57023429765, 43145.35281970773, 43161.0, 8790.86813697795, 9707.369021013628, 9884.555195016206, 9889.950550247238, 9894.109530142287, 8795.736127916172, 11916.940415297955, 12188.451519681592, 12199.634010979686, 12399.628011159679, 12123.454444550016, 12174.269543827399, 12189.756204875897, 12196.878031219663, 12199.390030498484, 9920.45437500937, 12014.519419223221, 12073.818892716616, 12156.088293378032, 12293.692657683629, 11867.109966752529, 11917.463714132798, 11925.701857453547, 11939.880601193963, 11944.641660750105, 40010.0, 40087.7995610023, 40137.197256054715, 40189.59810401888, 40319.7984010081, 3272.1528134234936, 3279.7868138570916, 3523.2425028618713, 3536.6286539913194, 3607.206414588786, 30660.080197594107, 30887.073387798402, 31644.683553164403, 31993.52009719856, 33184.004479865645, 2973.2864112613033, 3024.5311976643657, 3061.7091376319213, 3089.7682673799554, 3093.9381212375624, 535950.0, 542926.2853685706, 543775.0, 545081.0, 546552.0, 31961.0, 59111.11333330003, 59461.0, 59532.70233648804, 59612.70193649004, 33124.0, 33336.666633333356, 34798.47802282968, 35062.47406288908, 35168.47247291293, 13429.731405371838, 14685.77971330431, 14689.118652880648, 14695.706085878222, 14720.263986800617, 9731.708048758548, 11344.20590558653, 11493.655190344303, 12494.50021999128, 12616.747665046647, 7334.413246940232, 7445.590492522963, 7526.962365188139, 7770.494917830323, 7779.260970207822, 2817.7323154300307, 3043.786934914535, 3066.1414803854955, 3260.1523603863166, 3280.5735254416772, 873.6461732998146, 902.7246689759686, 989.747614358334, 1012.1801340913884, 1022.0597050713361, 29048.41903161925, 29979.303932252802, 30118.0, 30631.38737225243, 30930.226744331572, 1009.4649835587151, 1093.5516438260433, 1095.7917995580815, 1138.4592318648577, 1151.8099513580332, 12606.936965315115, 15578.065316080845, 15627.453039143575, 15783.131927744083, 16068.517944461684, 716087.0, 726205.0, 727539.0, 727745.0, 728129.0780638295, 57480.0, 58022.7098864503, 58072.4192758067, 58085.70957145187, 58100.70949645309, 1253.147859455579, 1288.3171918883006, 1291.4382243724199, 1379.7306478040227, 1405.3605609447677, 21789.782102178775, 23668.52662946766, 28704.425911481234, 32169.839150804095, 32616.0, 52656.47343526669, 53349.0, 53387.0, 53396.4660353407, 53467.6633084176, 624933.0, 630765.8461707846, 633069.0, 633075.0, 633793.0, 26159.084432044787, 26530.204093877215, 26716.332091697863, 26868.46263074767, 27196.592051118852, 47084.29373559331, 47404.52595474001, 47549.0, 48289.75855120702, 48503.27245091256, 38592.0, 38840.8347749568, 39052.80473597614, 40103.0, 40144.397834033094, 38069.61930380772, 38344.6165538341, 38557.036074098374, 39653.80173099116, 39858.800705996284, 37522.624773751915, 38486.42270366003, 38963.41554876622, 38995.0, 39156.02109947274, 31872.840635796674, 33531.4970275451, 34631.787887423816, 34768.30463390667, 34786.0, 20799.584008320053, 22525.774742252368, 25492.85282162344, 25788.871055644602, 25992.0], "value": 19143.9453009889, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.57248584241364, 362.76782858970256, 364.2042137928626, 368.9022409061598, 394.93088709475853, 15168.317425715855, 15543.455979040737, 20751.481212969644, 20912.163513459443, 21538.56922861542, 11919.76160476792, 14453.132812031285, 20013.499662508446, 20584.485387865312, 20808.89595552024, 5389.9191512127345, 5612.102063669814, 5617.9719101404435, 5628.887422251552, 5628.98678237917, 5068.0, 5516.117421212607, 6157.846053848645, 6246.968765156168, 6291.748330066815, 6205.7517699291975, 6232.626042437446, 6232.813015609517, 6242.812715618538, 6251.749930002795, 6785.457163426914, 6830.487713421513, 6863.14210723662, 6864.725410983555, 6870.175578930561, 5807.419258074159, 5985.820425387245, 6048.848778780522, 6051.334353221142, 6076.240469941257, 13538.390772415167, 13576.0, 13605.863941360558, 13694.657633559142, 13710.52013179534, 2233.687283780272, 2313.745487996319, 2393.820463465247, 2427.781499665021, 2937.6327959005125, 9898.802023959552, 9974.601015959426, 10545.420001899893, 10610.57557697699, 10648.361098334124, 1898.3450709505198, 1951.31703903634, 1961.3135402609116, 1963.4502339345006, 2074.4917495213767, 122753.0, 129650.0, 130223.69776302305, 134864.999999999, 135050.29899402056, 9554.187894028946, 9756.0, 9942.105210531086, 10031.197504199647, 10219.386836789816, 12362.690932726753, 12459.0, 12492.81260781089, 12517.374131293398, 12522.998160147166, 6946.79159625212, 8197.4671646344, 8284.171582841667, 8299.128591497927, 8489.74530764078, 6492.577982431221, 8145.959270203611, 8392.496450213006, 8470.322374210049, 9023.368364214442, 3832.3868181090893, 3907.4724912137067, 3918.1575961167914, 3965.3060714375447, 3994.400839874042, 1913.2251438167286, 1951.2195121951333, 1952.077203954104, 1982.1664959912023, 1997.5605366819277, 758.3857075768645, 905.6558507767006, 925.8287216864901, 928.5450129436663, 939.9718008459757, 20842.791572084087, 21548.676769848465, 21556.89221553882, 21641.675374869388, 21684.89157554202, 914.2183433164681, 939.2720641502754, 951.191487235844, 963.9084286992725, 1022.6522982186092, 10372.481375931173, 10682.586906529872, 11048.0, 11052.226344155994, 11233.887661123448, 547009.0, 571010.1449492809, 578588.0, 606512.0, 614953.0, 117330.0, 120733.79266207226, 138342.0, 138910.0, 145081.0, 937.7749340158449, 940.5344354544408, 964.4454438697777, 967.2697113679127, 968.8062387522383, 19031.809681903556, 19246.4226073218, 19281.710774338117, 19366.322178723676, 19372.321968731027, 54146.0, 55201.0, 55956.72021639866, 56100.15849762175, 56353.436465636456, 78791.81812272705, 80832.19167808247, 81436.0, 83364.0, 83467.0, 7584.886226706493, 7690.538567685957, 7930.405219608437, 11620.825687614863, 11764.647060588197, 11609.941950290195, 13513.729725405634, 13807.723845523235, 14396.640083997983, 14563.781543276647, 11495.367754773568, 11778.82331765007, 12079.39603019863, 12130.090243231616, 12187.51249949992, 11461.369624670722, 11657.358845263592, 11818.054555635357, 11946.880531194576, 12124.211926224767, 11806.35065071395, 12081.697957551132, 12136.089793265364, 12248.87751122513, 12312.938435308124, 12346.81479777786, 12397.814032789696, 12688.555900543437, 12718.745625087631, 12796.296203708513, 11605.361705106301, 11618.88381116178, 11893.108016898941, 11989.64031079069, 12073.0], "value": 9601.897410084623, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.0, 1554.9144797036163, 1578.550113217733, 1755.964880702386, 1870.869039167258, 7745.109312429072, 8510.361722870786, 8786.648534058646, 8788.78028049299, 8902.154295341948, 8625.266852317545, 8711.0, 8723.171298726611, 8725.214730674237, 8726.1710137537, 2369.194473878885, 2397.928062158138, 2402.5074859653814, 2403.267003563912, 2403.795677367426, 2343.121329501437, 2375.4298968247667, 2392.4856155926473, 2393.413613664655, 2393.413613664655, 2350.612148995414, 2368.7039120109985, 2385.6421536769535, 2391.270662447953, 2393.7606239376096, 2336.556054349668, 2361.327021798788, 2365.6333268343433, 2373.062640257106, 2384.2966324934187, 2320.454693147109, 2344.6951896253377, 2345.2377977157494, 2351.1183306260154, 2356.2577787996897, 8583.313334933191, 8658.913410865936, 8722.476651400937, 8772.868406973901, 8821.073787252375, 5186.662866913676, 5386.676799392049, 5387.326584176978, 5392.649477783971, 5406.756695948652, 3079.938401231963, 3571.232185080194, 3583.3549961007006, 3639.2175682228185, 3643.453481977698, 1100.9009189173014, 1109.362116782853, 1110.8889111088906, 1125.5779082843933, 1128.8758236593967, 11486.368249746261, 11569.0, 11613.1290153238, 11625.59310424131, 11648.708782280512, 4346.130773845243, 4430.867073987785, 4601.976990115028, 4611.746353950565, 4630.83792067276, 9032.548372581476, 9034.412763170372, 9048.276137908952, 9048.918748687838, 9050.411723237969, 5172.301739265226, 5175.378954525481, 5177.8446646599905, 5179.456157103526, 5181.4041385240425, 4195.685323600742, 4281.550437204111, 4351.695381323277, 4512.435945506812, 4834.395700537433, 3404.727621790251, 3713.9071523212137, 3781.2248489059675, 3838.2131663009573, 3848.422736589534, 1122.764219513895, 1126.5099681638349, 1145.3185354713933, 1179.7404570994368, 1201.0991756182864, 896.7354630384052, 918.3815765882403, 933.5425641435647, 934.3693007220099, 949.4777872170279, 5716.171155182558, 5869.090291004901, 5944.554158438134, 6125.754969801247, 6142.846428839225, 428.74918172869224, 452.9297958816389, 458.0, 458.27134855579123, 465.43914582927493, 3798.9810050950123, 3803.980980095082, 3988.8603898863403, 3992.48097747291, 3997.84008639657, 10455.529501172465, 10481.475926203659, 10878.0, 10919.781604367869, 10933.726656833484, 10728.517216725266, 10870.565177392973, 10870.673879783619, 10877.728056798644, 10881.619143329945, 6475.377472123798, 7532.698692052366, 7956.761297161094, 8169.142240064826, 8266.545340006238, 5934.970325148347, 5951.256092988377, 5967.91048134287, 5979.701014949323, 6094.7257373417415, 9804.460754658563, 10117.19062475015, 10144.087032167141, 10152.543135559064, 10173.28786984904, 7839.764807055797, 9289.62841486333, 10014.048665376778, 10015.799684006424, 10161.441120738134, 7001.894971575329, 7352.742654007084, 7504.174540800616, 7597.088349397886, 7599.316061554487, 8151.470154439942, 8156.959215204123, 8158.592070396575, 8251.092379838334, 8296.626651800563, 6571.967140164268, 7493.138289096605, 7500.587467689329, 7565.356944659766, 7567.810804729926, 6260.28006779208, 7274.0, 7354.558726476428, 7371.447141464519, 7446.925530744623, 6987.7204911802955, 7087.255838136922, 7087.645617719197, 7092.9645351772915, 7110.39561637246, 4889.095517329305, 4897.8285759998225, 4971.925421118758, 5058.797648094035, 5184.170532714747, 5162.97418512905, 5191.117510023229, 5261.3686357637325, 5435.673859568438, 5485.341758988947], "value": 4457.183278024868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.6387045553275, 310.58691939720177, 313.74900079936043, 315.10038839114316, 316.90017644441986, 4645.976770116153, 5284.31303930489, 5304.787808487666, 5307.65500242484, 5352.518273355392, 4749.90500189996, 5046.84859454217, 5231.293775340328, 5245.291885595453, 5247.317848679666, 3785.31864264433, 3808.638179372955, 3959.4258832469272, 4032.919341613166, 4088.8773336799795, 3245.529398237254, 3659.0361806936335, 4012.71910966231, 4019.3167161582455, 4061.451704019949, 3608.368535506289, 3653.1962968146963, 3898.8830335089992, 3968.325384684596, 3971.8212680429306, 3666.9633303666888, 3725.926110958443, 3994.8202330895033, 4023.9537720192666, 4028.4964379452567, 3421.2722575099665, 3466.9479957800654, 3508.122969257686, 3516.82415879205, 3540.1945008045823, 4285.657147428198, 4364.650827933758, 5034.993001399735, 5063.949360506384, 5117.974410127963, 3911.8630847920185, 4202.0, 4557.95442045582, 4572.1424109931295, 4590.563896429834, 5289.206619007141, 5471.50756431919, 5483.616146869721, 5492.697901615409, 5509.851158048365, 3615.94576081359, 3643.653852883972, 3665.7433979621437, 3780.432935059763, 3828.1195325075387, 4925.2858335541505, 5218.712970786643, 5430.321209848769, 5781.335146458169, 5791.362950075489, 3406.846691898821, 3773.2831561639387, 3791.9241615167543, 3835.9232815343535, 3840.2127563849344, 3851.3837785954674, 3858.2090671412293, 3880.5537363203593, 3884.786336751449, 3896.2207558488417, 4324.481062272547, 4533.637309015271, 4538.72767633943, 4556.65825063115, 4564.84023059198, 4744.7627618618935, 4858.368412106403, 5188.948110518922, 5512.283403157564, 5547.446714919748, 1112.3048094940661, 1325.7149712811793, 1329.6609364612154, 1333.2467156056796, 1339.5579458778775, 776.4060493722307, 807.6028470745642, 814.1532805881935, 819.3404309530765, 822.7120507822334, 4921.999999999928, 5037.269595908573, 5063.025420086169, 5137.33214682089, 5140.537351638296, 5401.108817045222, 5673.6028478006965, 5683.715814209273, 5687.1753595729215, 5688.914666280009, 4198.1393814268, 5126.282320475137, 5144.768485418165, 5147.742612869341, 5196.32447781786, 2913.621229240185, 2973.988843793121, 2979.2998645318335, 2983.746381557592, 2985.671576126624, 4990.3032968790785, 5164.8192313268855, 5552.641176676289, 5670.177824215466, 5826.70866456684, 4520.9095818084115, 5288.735563221823, 5779.306483221956, 5781.942180578225, 5871.706414679335, 5346.812861549827, 5504.788946431779, 5645.379008309001, 5832.708364581754, 5915.615484993462, 4533.682642215013, 5718.083777273703, 5721.971390143022, 5738.581292404909, 5754.4533269339345, 4455.658256307769, 5614.775408983595, 5614.803481878114, 5664.858378540404, 5701.7149142541875, 4463.553644635511, 5235.973820130875, 5359.14253719403, 5889.911651325147, 5970.940290597038, 3762.3792074307435, 3835.4438606402473, 3981.402789581586, 4007.499062617173, 4008.659263962596, 4743.596794272526, 5098.566621837037, 5204.7918083276245, 5310.389305229948, 5671.744771485375, 4721.811127554859, 5484.0, 5509.944900550943, 5549.250851135206, 5553.0, 5169.604206864051, 5407.675539467645, 5500.917486237629, 5528.889422211614, 5553.362152977304, 4721.244600863845, 5407.486288802557, 5421.7560209791445, 5442.891142177214, 5505.559555235652, 4473.175435003026, 4637.60580350674, 5227.001343971789, 5483.369412517452, 5573.832785016456, 5399.217113518596, 5400.378956419905, 5439.449756819287, 5441.700706461024, 5460.699661518495], "value": 4003.9493182762676, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.3873146556892, 748.535907737203, 754.724525548175, 789.6209819286743, 832.7127141136306, 15839.683206335882, 16611.41860034899, 16636.0, 16655.66688666226, 16658.916705416457, 14774.778378324334, 15035.0, 15039.323230454629, 15112.47106351278, 15122.24388780562, 694.6144889586277, 711.3384552366298, 841.3395484544649, 856.1908995998783, 883.5449743382163, 862.995685021574, 875.3784812782932, 876.1019954546578, 877.6182360673096, 885.3536918049828, 931.2689538712112, 931.8136372725448, 933.5099072986668, 934.6822080492631, 934.7055677461611, 931.0782325497776, 931.3992474853716, 932.3054324528202, 933.1321870660283, 933.1788026536672, 547.1956224350199, 575.4446958684847, 670.1924181361447, 692.4079911675495, 693.7814588404636, 14916.776248356284, 14957.177355245458, 14964.551063468005, 14972.0, 14978.325975331027, 13855.515056972958, 14318.785218221736, 14355.138691678532, 14400.855991440056, 14417.423303067864, 12942.352882355844, 13153.473861045546, 13171.0, 13342.533011344653, 13521.729565408637, 4693.296005599153, 4702.27114797207, 4880.389951256093, 4894.657373983787, 4903.607711383081, 119124.0, 121085.0, 128458.0, 129591.35204323918, 130932.34533827365, 11004.284721493077, 11275.774484510264, 11398.658040258806, 11531.538738450536, 11829.093417089693, 22711.659325110137, 22806.65790013151, 22812.65781013286, 22822.087116515486, 22887.771122288897, 7158.105236845395, 8069.919300806917, 8078.43450958439, 8099.856321839038, 8164.224398682116, 4483.910321793546, 4529.501754806968, 4557.908841823145, 4718.268668356411, 4728.361671174347, 3461.9134521636656, 3574.5531808523933, 3576.91057723559, 3579.087332730137, 3588.372034893883, 648.8669822686338, 650.440621065883, 658.5916731626422, 677.5697432130632, 678.6064082831946, 553.9695316757617, 566.9801556945487, 621.9440250377488, 630.3129588748286, 636.1094467745194, 7339.449541284425, 8801.119888011148, 8922.973858006413, 8944.418612790148, 9128.771780705403, 542.8697112692926, 551.9061759500895, 559.4293820303268, 589.8945909833192, 640.897456406982, 4227.957720422818, 4387.714798538085, 4395.626371758372, 4453.821847126079, 4474.172278128557, 147774.52225477822, 148765.0, 168694.75662920528, 170501.0, 172742.0, 110806.59514263095, 123307.53384932251, 127921.36039319744, 129982.0, 131832.0, 79262.6036869812, 97391.99999999859, 97523.51238243905, 106624.0, 118184.0, 9310.348275620641, 9471.431714097176, 9628.374155679858, 9987.700368988651, 10032.147267482345, 63454.68272658792, 63493.0, 64581.03128452983, 66399.33600664124, 66516.6674166626, 84510.0, 89814.55092724494, 94923.52538237265, 96513.03486965041, 98165.0, 12625.87374126247, 13157.27634980047, 13233.691577105723, 13414.597562073153, 13532.93233533826, 10675.0, 14966.476173333882, 15032.24838758036, 15131.848681513044, 15491.07053576789, 10654.573817047542, 13113.475460981454, 13827.792583111463, 13884.652883677585, 13966.650833729238, 13202.075854690464, 13766.724665506434, 13851.099678520864, 14049.719005619625, 14155.575332740034, 13555.525556605471, 13586.184828910296, 13687.726245475234, 13981.370838312097, 14117.505887294306, 10864.619738309122, 10917.781644367227, 11302.265352752045, 11449.542018319175, 11529.308241505536, 10908.945455272673, 10934.453277335942, 10936.179786516203, 11371.54513819438, 11454.140939429743], "value": 7947.96721323346, "unit": "score"}], "name": "dromaeo_css", "value": 7277.035114280876, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 113.0, 112.0, 114.0, 112.0, 113.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 107.0, 113.0, 151.0, 138.0, 138.0, 134.0, 102.0, 156.0, 106.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 185.0, 182.0, 184.0, 178.0, 183.0, 183.0, 183.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 48.0, 86.0, 74.0, 81.0, 83.0, 82.0, 84.0, 57.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 105.0, 72.0, 75.0, 68.0, 95.0, 71.0, 67.0, 103.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 87.0, 89.0, 86.0, 90.0, 87.0, 90.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 103.0, 130.0, 134.0, 85.0, 86.0, 101.0, 131.0, 139.0, 84.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 54.0, 52.0, 56.0, 54.0, 53.0, 54.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 76.0, 73.0, 71.0, 67.0, 66.0, 68.0, 68.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 84.0, 88.0, 87.0, 82.0, 83.0, 84.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 134.0, 127.0, 136.0, 136.0, 132.0, 140.0, 158.0, 144.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 169.0, 167.0, 168.0, 168.0, 167.0, 186.0, 230.0, 190.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1458.4, "alertThreshold": 2.0}]} 10:27:04 INFO - Return code: 0 10:27:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:27:04 INFO - # TBPL SUCCESS # 10:27:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:27:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:27:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:27:04 INFO - 2016-08-19 10:27:04.552 screenresolution[1669:10231] starting screenresolution argv=screenresolution get 10:27:04 INFO - 2016-08-19 10:27:04.555 screenresolution[1669:10231] Display 0: 1600x1200x32@60 10:27:04 INFO - 2016-08-19 10:27:04.561 screenresolution[1670:10234] starting screenresolution argv=screenresolution list 10:27:04 INFO - Available Modes on Display 0 10:27:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:27:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:27:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:27:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:27:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:27:04 INFO - Intel Iris: 10:27:04 INFO - Chipset Model: Intel Iris 10:27:04 INFO - Type: GPU 10:27:04 INFO - Bus: Built-In 10:27:04 INFO - VRAM (Dynamic, Max): 1536 MB 10:27:04 INFO - Vendor: Intel (0x8086) 10:27:04 INFO - Device ID: 0x0a2e 10:27:04 INFO - Revision ID: 0x0009 10:27:04 INFO - Displays: 10:27:04 INFO - Display: 10:27:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:27:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:27:04 INFO - Display Serial Number: 1600x1200 60 10:27:04 INFO - Main Display: Yes 10:27:04 INFO - Mirror: Off 10:27:04 INFO - Online: Yes 10:27:04 INFO - Rotation: Supported 10:27:04 INFO - Return code: 0 10:27:04 INFO - Running post-action listener: _resource_record_post_action 10:27:04 INFO - [mozharness: 2016-08-19 17:27:04.795315Z] Finished run-tests step (success) 10:27:04 INFO - Running post-run listener: _resource_record_post_run 10:27:04 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31812608; Write bytes: 704278016; Read time: 194; Write time: 1966 10:27:04 INFO - TinderboxPrint: CPU usage
53.6% 10:27:04 INFO - TinderboxPrint: I/O read bytes / time
31,812,608 / 194 10:27:04 INFO - TinderboxPrint: I/O write bytes / time
704,278,016 / 1,966 10:27:04 INFO - TinderboxPrint: CPU idle
2,249.7 (46.4%) 10:27:04 INFO - TinderboxPrint: CPU system
974.9 (20.1%) 10:27:04 INFO - TinderboxPrint: CPU user
1,625.1 (33.5%) 10:27:04 INFO - TinderboxPrint: Swap in / out
433,430,528 / 0 10:27:04 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 282624; Write bytes: 407930368; Read time: 4; Write time: 859 10:27:04 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29080576; Write bytes: 294778880; Read time: 170; Write time: 1099 10:27:05 INFO - Running post-run listener: _upload_blobber_files 10:27:05 INFO - Blob upload gear active. 10:27:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:05 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 10:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:06 INFO - (blobuploader) - INFO - Done attempting. 10:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:07 INFO - (blobuploader) - INFO - Done attempting. 10:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:09 INFO - (blobuploader) - INFO - Done attempting. 10:27:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:09 INFO - Return code: 0 10:27:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d242174de1a2445a216a9b3cd5fc864ff26c87447a6fefc7c3786f50d4ec5ef7085d2f323f93533beb8c3734bb3c43b1f410c0d9b342cc58b13b6f4f4b9d1420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/881967fa802ecd7c9168d6471d3076782c58a3184af2d26928b1e8681dd321fa399d9b17ba8f256abedb8b5ea080c9dd53385f670ba517d38c16093730770987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63b61d12bc0105d02d46882b98a459c0b584c81b56cf84d3816c5d5bc61e7c020ea38e2aa6717d40640e82aa8a77c69f1885244c09ab5c8cb82cac739c4a119e"} 10:27:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:09 INFO - Contents: 10:27:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d242174de1a2445a216a9b3cd5fc864ff26c87447a6fefc7c3786f50d4ec5ef7085d2f323f93533beb8c3734bb3c43b1f410c0d9b342cc58b13b6f4f4b9d1420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/881967fa802ecd7c9168d6471d3076782c58a3184af2d26928b1e8681dd321fa399d9b17ba8f256abedb8b5ea080c9dd53385f670ba517d38c16093730770987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63b61d12bc0105d02d46882b98a459c0b584c81b56cf84d3816c5d5bc61e7c020ea38e2aa6717d40640e82aa8a77c69f1885244c09ab5c8cb82cac739c4a119e"} 10:27:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:09 INFO - Copying logs to upload dir... 10:27:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.189948 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-19 10:27:10.256543) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 10:27:10.261046) ========= 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.ceNe9atk3E/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.CxPL6zxGvx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d242174de1a2445a216a9b3cd5fc864ff26c87447a6fefc7c3786f50d4ec5ef7085d2f323f93533beb8c3734bb3c43b1f410c0d9b342cc58b13b6f4f4b9d1420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/881967fa802ecd7c9168d6471d3076782c58a3184af2d26928b1e8681dd321fa399d9b17ba8f256abedb8b5ea080c9dd53385f670ba517d38c16093730770987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63b61d12bc0105d02d46882b98a459c0b584c81b56cf84d3816c5d5bc61e7c020ea38e2aa6717d40640e82aa8a77c69f1885244c09ab5c8cb82cac739c4a119e"} build_url:https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011086 build_url: 'https://queue.taskcluster.net/v1/task/HNLmzWreTkWbSflLr3cU2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d242174de1a2445a216a9b3cd5fc864ff26c87447a6fefc7c3786f50d4ec5ef7085d2f323f93533beb8c3734bb3c43b1f410c0d9b342cc58b13b6f4f4b9d1420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/881967fa802ecd7c9168d6471d3076782c58a3184af2d26928b1e8681dd321fa399d9b17ba8f256abedb8b5ea080c9dd53385f670ba517d38c16093730770987", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63b61d12bc0105d02d46882b98a459c0b584c81b56cf84d3816c5d5bc61e7c020ea38e2aa6717d40640e82aa8a77c69f1885244c09ab5c8cb82cac739c4a119e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 10:27:10.302017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-19 10:27:10.302360) ========= 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.ceNe9atk3E/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.CxPL6zxGvx/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.004554 ========= master_lag: 3.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-19 10:27:13.581144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 10:27:13.581485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 10:27:13.584604) ========= ========= Total master_lag: 4.23 =========