builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0101 starttime: 1471888555.21 results: success (0) buildid: 20160822083415 builduid: 9d113c52882747508773e1dbede12a3b revision: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.214687) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.215103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.215389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.240260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.240753) ========= 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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-22 10:55:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.46M=0.001s 2016-08-22 10:55:55 (8.46 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123149 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.389299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.389955) ========= 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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.020238 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:55.440315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 10:55:55.441032) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b7148db9a79bb17fd85df31690c98ffb5c8a541 --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 3b7148db9a79bb17fd85df31690c98ffb5c8a541 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E9rjnEHLaN/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.emoHYJHWLQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-22 10:55:55,521 truncating revision to first 12 chars 2016-08-22 10:55:55,521 Setting DEBUG logging. 2016-08-22 10:55:55,521 attempt 1/10 2016-08-22 10:55:55,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b7148db9a79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 10:55:56,571 unpacking tar archive at: fx-team-3b7148db9a79/testing/mozharness/ program finished with exit code 0 elapsedTime=1.329557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 10:55:56.793684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:56.794032) ========= script_repo_revision: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:56.794484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:56.794770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 10:55:56.813289) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-22 10:55:56.813572) ========= /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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:55:56 INFO - MultiFileLogger online at 20160822 10:55:56 in /builds/slave/test 10:55:56 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:55:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:55:56 INFO - {'append_to_log': False, 10:55:56 INFO - 'base_work_dir': '/builds/slave/test', 10:55:56 INFO - 'blob_upload_branch': 'Fx-Team', 10:55:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:55:56 INFO - 'branch': 'Fx-Team', 10:55:56 INFO - 'buildbot_json_path': 'buildprops.json', 10:55:56 INFO - 'config_files': ('talos/mac_config.py',), 10:55:56 INFO - 'default_actions': ('clobber', 10:55:56 INFO - 'read-buildbot-config', 10:55:56 INFO - 'download-and-extract', 10:55:56 INFO - 'populate-webroot', 10:55:56 INFO - 'create-virtualenv', 10:55:56 INFO - 'install', 10:55:57 INFO - 'run-tests'), 10:55:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:55:57 INFO - 'download_minidump_stackwalk': True, 10:55:57 INFO - 'download_symbols': 'ondemand', 10:55:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:55:57 INFO - 'tooltool.py': '/tools/tooltool.py', 10:55:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:55:57 INFO - '/tools/misc-python/virtualenv.py')}, 10:55:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:55:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:55:57 INFO - 'installer_path': 'installer.exe', 10:55:57 INFO - 'log_level': 'info', 10:55:57 INFO - 'log_name': 'talos', 10:55:57 INFO - 'log_to_console': True, 10:55:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:55:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:55:57 INFO - 'opt_config_files': (), 10:55:57 INFO - 'pip_index': False, 10:55:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:57 INFO - 'cmd': ('bash', 10:55:57 INFO - '-c', 10:55:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:57 INFO - 'enabled': True, 10:55:57 INFO - 'halt_on_failure': False, 10:55:57 INFO - 'name': 'check_screen_resolution'},), 10:55:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:57 INFO - 'cmd': ('bash', 10:55:57 INFO - '-c', 10:55:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:57 INFO - 'enabled': True, 10:55:57 INFO - 'halt_on_failure': False, 10:55:57 INFO - 'name': 'check_screen_resolution'},), 10:55:57 INFO - 'run_cmd_checks_enabled': True, 10:55:57 INFO - 'sps_profile': False, 10:55:57 INFO - 'sps_profile_interval': 0, 10:55:57 INFO - 'suite': 'dromaeojs', 10:55:57 INFO - 'system_bits': '32', 10:55:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:55:57 INFO - 'title': 't-yosemite-r7-0101', 10:55:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:55:57 INFO - 'use_talos_json': True, 10:55:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:55:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:55:57 INFO - 'work_dir': 'build'} 10:55:57 INFO - [mozharness: 2016-08-22 17:55:57.004636Z] Running clobber step. 10:55:57 INFO - Running pre-action listener: _resource_record_pre_action 10:55:57 INFO - Running main action method: clobber 10:55:57 INFO - rmtree: /builds/slave/test/build 10:55:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:55:57 INFO - Running post-action listener: _resource_record_post_action 10:55:57 INFO - [mozharness: 2016-08-22 17:55:57.182758Z] Finished clobber step (success) 10:55:57 INFO - [mozharness: 2016-08-22 17:55:57.182835Z] Running read-buildbot-config step. 10:55:57 INFO - Running pre-action listener: _resource_record_pre_action 10:55:57 INFO - Running main action method: read_buildbot_config 10:55:57 INFO - Using buildbot properties: 10:55:57 INFO - { 10:55:57 INFO - "project": "", 10:55:57 INFO - "product": "firefox", 10:55:57 INFO - "script_repo_revision": "production", 10:55:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:55:57 INFO - "repository": "", 10:55:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:55:57 INFO - "buildid": "20160822083415", 10:55:57 INFO - "pgo_build": "False", 10:55:57 INFO - "basedir": "/builds/slave/test", 10:55:57 INFO - "buildnumber": 124, 10:55:57 INFO - "slavename": "t-yosemite-r7-0101", 10:55:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:55:57 INFO - "platform": "yosemite_r7", 10:55:57 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:55:57 INFO - "branch": "fx-team", 10:55:57 INFO - "repo_path": "integration/fx-team", 10:55:57 INFO - "revision": "3b7148db9a79bb17fd85df31690c98ffb5c8a541", 10:55:57 INFO - "stage_platform": "macosx64", 10:55:57 INFO - "builduid": "9d113c52882747508773e1dbede12a3b", 10:55:57 INFO - "slavebuilddir": "test" 10:55:57 INFO - } 10:55:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:55:57 INFO - Running post-action listener: _resource_record_post_action 10:55:57 INFO - [mozharness: 2016-08-22 17:55:57.186359Z] Finished read-buildbot-config step (success) 10:55:57 INFO - [mozharness: 2016-08-22 17:55:57.186489Z] Running download-and-extract step. 10:55:57 INFO - Running pre-action listener: _resource_record_pre_action 10:55:57 INFO - Running main action method: download_and_extract 10:55:57 INFO - mkdir: /builds/slave/test/build/tests 10:55:57 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:55:57 INFO - trying https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:55:57 INFO - Downloading https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:55:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:55:58 INFO - Downloaded 1199 bytes. 10:55:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:55:58 INFO - Using the following test package requirements: 10:55:58 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:55:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:55:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:55:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'jsshell-mac.zip'], 10:55:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:55:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:55:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:55:58 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:55:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:55:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:55:58 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:55:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:55:58 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:55:58 INFO - trying https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:55:58 INFO - Downloading https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:55:59 INFO - Downloaded 16352478 bytes. 10:55:59 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:56:06 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:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:06 INFO - trying https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:56:06 INFO - Downloading https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:56:07 INFO - Downloaded 16352478 bytes. 10:56:07 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:56:13 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:56:13 INFO - trying https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:56:13 INFO - Downloading https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:56:14 INFO - Downloaded 14413981 bytes. 10:56:14 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:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:15 INFO - trying https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:56:15 INFO - Downloading https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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:56:18 INFO - Downloaded 111476632 bytes. 10:56:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:56:18 INFO - mkdir: /builds/slave/test/properties 10:56:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:56:18 INFO - Writing to file /builds/slave/test/properties/build_url 10:56:18 INFO - Contents: 10:56:18 INFO - build_url:https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:56:18 INFO - Running post-action listener: _resource_record_post_action 10:56:18 INFO - Running post-action listener: set_extra_try_arguments 10:56:18 INFO - [mozharness: 2016-08-22 17:56:18.779673Z] Finished download-and-extract step (success) 10:56:18 INFO - [mozharness: 2016-08-22 17:56:18.779791Z] Running populate-webroot step. 10:56:18 INFO - Running pre-action listener: _resource_record_pre_action 10:56:18 INFO - Running main action method: populate_webroot 10:56:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:18 INFO - '--tppagecycles', 10:56:18 INFO - '7'], 10:56:18 INFO - 'tests': ['tsvgm']}}, 10:56:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:56:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:56:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:56:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['damp', 'tps']}, 10:56:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'tests': ['damp', 'tps']}, 10:56:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['dromaeo_dom']}, 10:56:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['basic_compositor_video']}, 10:56:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:56:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['a11yr', 10:56:18 INFO - 'ts_paint', 10:56:18 INFO - 'tpaint', 10:56:18 INFO - 'sessionrestore', 10:56:18 INFO - 'sessionrestore_no_auto_restore', 10:56:18 INFO - 'tabpaint']}, 10:56:18 INFO - 'other-e10s': {'tests': ['a11yr', 10:56:18 INFO - 'ts_paint', 10:56:18 INFO - 'tpaint', 10:56:18 INFO - 'sessionrestore', 10:56:18 INFO - 'sessionrestore_no_auto_restore', 10:56:18 INFO - 'tabpaint']}, 10:56:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:56:18 INFO - 'ts_paint', 10:56:18 INFO - 'tpaint', 10:56:18 INFO - 'sessionrestore', 10:56:18 INFO - 'sessionrestore_no_auto_restore', 10:56:18 INFO - 'tabpaint']}, 10:56:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:56:18 INFO - 'ts_paint', 10:56:18 INFO - 'tpaint', 10:56:18 INFO - 'sessionrestore', 10:56:18 INFO - 'sessionrestore_no_auto_restore', 10:56:18 INFO - 'tabpaint']}, 10:56:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['a11yr', 10:56:18 INFO - 'ts_paint', 10:56:18 INFO - 'tpaint', 10:56:18 INFO - 'sessionrestore', 10:56:18 INFO - 'sessionrestore_no_auto_restore', 10:56:18 INFO - 'tabpaint']}, 10:56:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['a11yr', 10:56:18 INFO - 'ts_paint', 10:56:18 INFO - 'tpaint', 10:56:18 INFO - 'sessionrestore', 10:56:18 INFO - 'sessionrestore_no_auto_restore', 10:56:18 INFO - 'tabpaint']}, 10:56:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['tsvgx', 10:56:18 INFO - 'tsvgr_opacity', 10:56:18 INFO - 'tart', 10:56:18 INFO - 'tscrollx', 10:56:18 INFO - 'cart']}, 10:56:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:56:18 INFO - 'tsvgr_opacity', 10:56:18 INFO - 'tart', 10:56:18 INFO - 'tscrollx', 10:56:18 INFO - 'cart']}, 10:56:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'talos_options': ['--disable-e10s'], 10:56:18 INFO - 'tests': ['tp5o']}, 10:56:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'tests': ['tp5o']}, 10:56:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'talos_options': ['--disable-e10s', 10:56:18 INFO - '--xperf_path', 10:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:18 INFO - 'tests': ['tp5n']}, 10:56:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:18 INFO - 'talos_options': ['--xperf_path', 10:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:18 INFO - 'tests': ['tp5n']}}, 10:56:18 INFO - 'talos.zip': {'path': '', 10:56:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:18 INFO - Running post-action listener: _resource_record_post_action 10:56:18 INFO - [mozharness: 2016-08-22 17:56:18.798682Z] Finished populate-webroot step (success) 10:56:18 INFO - [mozharness: 2016-08-22 17:56:18.798819Z] Running create-virtualenv step. 10:56:18 INFO - Running pre-action listener: _resource_record_pre_action 10:56:18 INFO - Running main action method: create_virtualenv 10:56:18 INFO - Creating virtualenv /builds/slave/test/build/venv 10:56:18 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:56:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:56:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:18 INFO - Using real prefix '/tools/python27' 10:56:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:56:19 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:22 INFO - Installing pip.................done. 10:56:22 INFO - Return code: 0 10:56:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:56:22 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:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:22 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:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:22 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:22 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:56:22 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:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:22 INFO - 'HOME': '/Users/cltbld', 10:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:22 INFO - 'LOGNAME': 'cltbld', 10:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:22 INFO - 'MOZ_NO_REMOTE': '1', 10:56:22 INFO - 'NO_EM_RESTART': '1', 10:56:22 INFO - 'PAGER': '/bin/cat', 10:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:22 INFO - 'PWD': '/builds/slave/test', 10:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:22 INFO - 'SHELL': '/bin/bash', 10:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:22 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:22 INFO - 'USER': 'cltbld', 10:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:22 INFO - 'XPC_FLAGS': '0x0', 10:56:22 INFO - 'XPC_SERVICE_NAME': '0', 10:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:22 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:56:22 INFO - Cleaning up... 10:56:22 INFO - Return code: 0 10:56:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:56:22 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:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:22 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:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:22 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:22 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:56:22 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:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:22 INFO - 'HOME': '/Users/cltbld', 10:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:22 INFO - 'LOGNAME': 'cltbld', 10:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:22 INFO - 'MOZ_NO_REMOTE': '1', 10:56:22 INFO - 'NO_EM_RESTART': '1', 10:56:22 INFO - 'PAGER': '/bin/cat', 10:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:22 INFO - 'PWD': '/builds/slave/test', 10:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:22 INFO - 'SHELL': '/bin/bash', 10:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:22 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:22 INFO - 'USER': 'cltbld', 10:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:22 INFO - 'XPC_FLAGS': '0x0', 10:56:22 INFO - 'XPC_SERVICE_NAME': '0', 10:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:23 INFO - Downloading/unpacking psutil>=3.1.1 10:56:23 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:56:23 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:56:23 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:56:23 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:56:23 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:56:23 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:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:26 INFO - Installing collected packages: psutil 10:56:26 INFO - Running setup.py install for psutil 10:56:26 INFO - building 'psutil._psutil_osx' extension 10:56:26 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:56:26 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:56:26 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:56:26 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:56:26 INFO - building 'psutil._psutil_posix' extension 10:56:26 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:56:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:56:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:56:26 INFO - ^ 10:56:26 INFO - 1 warning generated. 10:56:26 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:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:26 INFO - Successfully installed psutil 10:56:26 INFO - Cleaning up... 10:56:26 INFO - Return code: 0 10:56:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:56:26 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:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:26 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:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:26 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:26 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:56:26 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:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:26 INFO - 'HOME': '/Users/cltbld', 10:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:26 INFO - 'LOGNAME': 'cltbld', 10:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:26 INFO - 'MOZ_NO_REMOTE': '1', 10:56:26 INFO - 'NO_EM_RESTART': '1', 10:56:26 INFO - 'PAGER': '/bin/cat', 10:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:26 INFO - 'PWD': '/builds/slave/test', 10:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:26 INFO - 'SHELL': '/bin/bash', 10:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:26 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:26 INFO - 'USER': 'cltbld', 10:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:26 INFO - 'XPC_FLAGS': '0x0', 10:56:26 INFO - 'XPC_SERVICE_NAME': '0', 10:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:56:27 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:56:27 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:56:27 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:56:27 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:56:27 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:56:27 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:56:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:56:29 INFO - Installing collected packages: mozsystemmonitor 10:56:29 INFO - Running setup.py install for mozsystemmonitor 10:56:29 INFO - Successfully installed mozsystemmonitor 10:56:29 INFO - Cleaning up... 10:56:29 INFO - Return code: 0 10:56:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:56:29 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:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:29 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:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:29 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:29 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:56:29 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:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:29 INFO - 'HOME': '/Users/cltbld', 10:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:29 INFO - 'LOGNAME': 'cltbld', 10:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:29 INFO - 'MOZ_NO_REMOTE': '1', 10:56:29 INFO - 'NO_EM_RESTART': '1', 10:56:29 INFO - 'PAGER': '/bin/cat', 10:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:29 INFO - 'PWD': '/builds/slave/test', 10:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:29 INFO - 'SHELL': '/bin/bash', 10:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:29 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:29 INFO - 'USER': 'cltbld', 10:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:29 INFO - 'XPC_FLAGS': '0x0', 10:56:29 INFO - 'XPC_SERVICE_NAME': '0', 10:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:30 INFO - Downloading/unpacking jsonschema==2.5.1 10:56: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:56: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:56: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:56: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:56: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:56: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:56:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:56:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:56:32 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:56:32 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:56:32 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:56:32 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:56:32 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:56:32 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:56:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:56:33 INFO - warning: no files found matching '*.txt' 10:56:33 INFO - no previously-included directories found matching 'build' 10:56:33 INFO - no previously-included directories found matching 'dist' 10:56:33 INFO - no previously-included directories found matching '.git*' 10:56:33 INFO - Installing collected packages: jsonschema, functools32 10:56:33 INFO - Running setup.py install for functools32 10:56:33 INFO - warning: no files found matching '*.txt' 10:56:33 INFO - no previously-included directories found matching 'build' 10:56:33 INFO - no previously-included directories found matching 'dist' 10:56:33 INFO - no previously-included directories found matching '.git*' 10:56:33 INFO - Successfully installed jsonschema functools32 10:56:33 INFO - Cleaning up... 10:56:33 INFO - Return code: 0 10:56:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:56: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:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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', '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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:56: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 functools32==3.2.3-2 10:56:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:33 INFO - 'HOME': '/Users/cltbld', 10:56:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:33 INFO - 'LOGNAME': 'cltbld', 10:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:33 INFO - 'MOZ_NO_REMOTE': '1', 10:56:33 INFO - 'NO_EM_RESTART': '1', 10:56:33 INFO - 'PAGER': '/bin/cat', 10:56:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:33 INFO - 'PWD': '/builds/slave/test', 10:56:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:33 INFO - 'SHELL': '/bin/bash', 10:56:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:33 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:33 INFO - 'USER': 'cltbld', 10:56:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:33 INFO - 'XPC_FLAGS': '0x0', 10:56:33 INFO - 'XPC_SERVICE_NAME': '0', 10:56:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:56:33 INFO - Cleaning up... 10:56:33 INFO - Return code: 0 10:56:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:56: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:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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', '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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:56: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 blobuploader==1.2.4 10:56:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:33 INFO - 'HOME': '/Users/cltbld', 10:56:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:33 INFO - 'LOGNAME': 'cltbld', 10:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:33 INFO - 'MOZ_NO_REMOTE': '1', 10:56:33 INFO - 'NO_EM_RESTART': '1', 10:56:33 INFO - 'PAGER': '/bin/cat', 10:56:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:33 INFO - 'PWD': '/builds/slave/test', 10:56:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:33 INFO - 'SHELL': '/bin/bash', 10:56:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:33 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:33 INFO - 'USER': 'cltbld', 10:56:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:33 INFO - 'XPC_FLAGS': '0x0', 10:56:33 INFO - 'XPC_SERVICE_NAME': '0', 10:56:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:56: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:56: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:56: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:56: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:56: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:56: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:56:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:56:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:56: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:56: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:56: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:56: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:56: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:56: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:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:56:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56: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:56: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:56: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:56: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:56: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:56: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:56:37 INFO - Downloading docopt-0.6.1.tar.gz 10:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:37 INFO - Running setup.py install for blobuploader 10:56:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:56:37 INFO - Running setup.py install for requests 10:56:38 INFO - Running setup.py install for docopt 10:56:38 INFO - Successfully installed blobuploader requests docopt 10:56:38 INFO - Cleaning up... 10:56:38 INFO - Return code: 0 10:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:38 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:38 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:56:38 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:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:38 INFO - 'HOME': '/Users/cltbld', 10:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:38 INFO - 'LOGNAME': 'cltbld', 10:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:38 INFO - 'MOZ_NO_REMOTE': '1', 10:56:38 INFO - 'NO_EM_RESTART': '1', 10:56:38 INFO - 'PAGER': '/bin/cat', 10:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:38 INFO - 'PWD': '/builds/slave/test', 10:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:38 INFO - 'SHELL': '/bin/bash', 10:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:38 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:38 INFO - 'USER': 'cltbld', 10:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:38 INFO - 'XPC_FLAGS': '0x0', 10:56:38 INFO - 'XPC_SERVICE_NAME': '0', 10:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-iDZXiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Pj1HUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-cxKKcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-i_IVge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Syygnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Dy5W47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ZF1U7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-yZXUKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-M8OVaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-QlR7ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-rB6Zlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:39 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-5t4tJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-bnGj5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-WcBG3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-qLsIyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-qhHVC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-7_haau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:40 INFO - Running setup.py install for manifestparser 10:56:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:56:40 INFO - Running setup.py install for mozcrash 10:56:40 INFO - Running setup.py install for mozdebug 10:56:41 INFO - Running setup.py install for mozdevice 10:56:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Running setup.py install for mozfile 10:56:41 INFO - Running setup.py install for mozhttpd 10:56:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Running setup.py install for mozinfo 10:56:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Running setup.py install for mozInstall 10:56:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:56:41 INFO - Running setup.py install for mozleak 10:56:41 INFO - Running setup.py install for mozlog 10:56:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:56:42 INFO - Running setup.py install for moznetwork 10:56:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:56:42 INFO - Running setup.py install for mozprocess 10:56:42 INFO - Running setup.py install for mozprofile 10:56:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:56:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:56:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:56:42 INFO - Running setup.py install for mozrunner 10:56:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:56:42 INFO - Running setup.py install for mozscreenshot 10:56:42 INFO - Running setup.py install for moztest 10:56:43 INFO - Running setup.py install for mozversion 10:56:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:56:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:56:43 INFO - Cleaning up... 10:56:43 INFO - Return code: 0 10:56:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:43 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:43 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:56:43 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:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:43 INFO - 'HOME': '/Users/cltbld', 10:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:43 INFO - 'LOGNAME': 'cltbld', 10:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:43 INFO - 'MOZ_NO_REMOTE': '1', 10:56:43 INFO - 'NO_EM_RESTART': '1', 10:56:43 INFO - 'PAGER': '/bin/cat', 10:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:43 INFO - 'PWD': '/builds/slave/test', 10:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:43 INFO - 'SHELL': '/bin/bash', 10:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:43 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:43 INFO - 'USER': 'cltbld', 10:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:43 INFO - 'XPC_FLAGS': '0x0', 10:56:43 INFO - 'XPC_SERVICE_NAME': '0', 10:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-JhBPHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-MPksTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-1Z7XaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-X6KntT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-kiGQcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-3QUYZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-pEXmgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-xxsvy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-uZqAvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-gnIVVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-7YTM_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-r0NnVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-6KK0wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-MkvkUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:44 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:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VKhN9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:45 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:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-LtbXzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:45 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:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-MTHLI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:45 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:56:45 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:56:45 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:56:45 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:56:45 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:56:45 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:56:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:47 INFO - Downloading blessings-1.6.tar.gz 10:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:56:47 INFO - Installing collected packages: blessings 10:56:47 INFO - Running setup.py install for blessings 10:56:48 INFO - Successfully installed blessings 10:56:48 INFO - Cleaning up... 10:56:48 INFO - Return code: 0 10:56:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:56:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:48 INFO - Reading from file tmpfile_stdout 10:56:48 INFO - Current package versions: 10:56:48 INFO - blessings == 1.6 10:56:48 INFO - blobuploader == 1.2.4 10:56:48 INFO - docopt == 0.6.1 10:56:48 INFO - functools32 == 3.2.3-2 10:56:48 INFO - jsonschema == 2.5.1 10:56:48 INFO - manifestparser == 1.1 10:56:48 INFO - mozInstall == 1.12 10:56:48 INFO - mozcrash == 0.17 10:56:48 INFO - mozdebug == 0.1 10:56:48 INFO - mozdevice == 0.48 10:56:48 INFO - mozfile == 1.2 10:56:48 INFO - mozhttpd == 0.7 10:56:48 INFO - mozinfo == 0.9 10:56:48 INFO - mozleak == 0.1 10:56:48 INFO - mozlog == 3.3 10:56:48 INFO - moznetwork == 0.27 10:56:48 INFO - mozprocess == 0.23 10:56:48 INFO - mozprofile == 0.28 10:56:48 INFO - mozrunner == 6.12 10:56:48 INFO - mozscreenshot == 0.1 10:56:48 INFO - mozsystemmonitor == 0.3 10:56:48 INFO - moztest == 0.7 10:56:48 INFO - mozversion == 1.4 10:56:48 INFO - psutil == 3.1.1 10:56:48 INFO - requests == 1.2.3 10:56:48 INFO - wsgiref == 0.1.2 10:56:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:48 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:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 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:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:48 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:56:48 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:56:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:48 INFO - 'HOME': '/Users/cltbld', 10:56:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:48 INFO - 'LOGNAME': 'cltbld', 10:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:48 INFO - 'MOZ_NO_REMOTE': '1', 10:56:48 INFO - 'NO_EM_RESTART': '1', 10:56:48 INFO - 'PAGER': '/bin/cat', 10:56:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:48 INFO - 'PWD': '/builds/slave/test', 10:56:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:48 INFO - 'SHELL': '/bin/bash', 10:56:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:48 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:48 INFO - 'USER': 'cltbld', 10:56:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:48 INFO - 'XPC_FLAGS': '0x0', 10:56:48 INFO - 'XPC_SERVICE_NAME': '0', 10:56:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:48 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:56:48 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:56:48 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:56:48 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:56:48 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:56:48 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:56:48 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:56:48 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:56:48 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:56:48 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:56:48 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:56:48 INFO - Cleaning up... 10:56:48 INFO - Return code: 0 10:56:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:56:48 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:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 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:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 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 0x100baca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c41618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b3594170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, '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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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:56:48 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:56:48 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:56:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:56:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:48 INFO - 'HOME': '/Users/cltbld', 10:56:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:48 INFO - 'LOGNAME': 'cltbld', 10:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:48 INFO - 'MOZ_NO_REMOTE': '1', 10:56:48 INFO - 'NO_EM_RESTART': '1', 10:56:48 INFO - 'PAGER': '/bin/cat', 10:56:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:48 INFO - 'PWD': '/builds/slave/test', 10:56:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:48 INFO - 'SHELL': '/bin/bash', 10:56:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:56:48 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:56:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:48 INFO - 'USER': 'cltbld', 10:56:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:48 INFO - 'XPC_FLAGS': '0x0', 10:56:48 INFO - 'XPC_SERVICE_NAME': '0', 10:56:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:56:48 INFO - Cleaning up... 10:56:48 INFO - Return code: 0 10:56:48 INFO - Running post-action listener: _resource_record_post_action 10:56:48 INFO - Running post-action listener: _start_resource_monitoring 10:56:48 INFO - Starting resource monitoring. 10:56:48 INFO - [mozharness: 2016-08-22 17:56:48.953852Z] Finished create-virtualenv step (success) 10:56:48 INFO - [mozharness: 2016-08-22 17:56:48.954842Z] Running install step. 10:56:48 INFO - Running pre-action listener: _resource_record_pre_action 10:56:48 INFO - Running main action method: install 10:56:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:49 INFO - Reading from file tmpfile_stdout 10:56:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:56:49 INFO - Reading from file tmpfile_stdout 10:56:49 INFO - Output received: 10:56:49 INFO - Usage: mozinstall [options] installer 10:56:49 INFO - Options: 10:56:49 INFO - -h, --help show this help message and exit 10:56:49 INFO - -d DEST, --destination=DEST 10:56:49 INFO - Directory to install application into. [default: 10:56:49 INFO - "/builds/slave/test"] 10:56:49 INFO - --app=APP Application being installed. [default: firefox] 10:56:49 INFO - mkdir: /builds/slave/test/build/application 10:56:49 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:56:49 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:57:23 INFO - Reading from file tmpfile_stdout 10:57:23 INFO - Output received: 10:57:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:57:23 INFO - Running post-action listener: _resource_record_post_action 10:57:23 INFO - [mozharness: 2016-08-22 17:57:23.813565Z] Finished install step (success) 10:57:23 INFO - [mozharness: 2016-08-22 17:57:23.813708Z] Running run-tests step. 10:57:23 INFO - Running pre-action listener: _resource_record_pre_action 10:57:23 INFO - Running main action method: run_tests 10:57:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:57:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:57:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:57:23 INFO - 2016-08-22 10:57:23.828 screenresolution[1899:9023] starting screenresolution argv=screenresolution get 10:57:23 INFO - 2016-08-22 10:57:23.831 screenresolution[1899:9023] Display 0: 1600x1200x32@60 10:57:23 INFO - 2016-08-22 10:57:23.837 screenresolution[1900:9025] starting screenresolution argv=screenresolution list 10:57:23 INFO - Available Modes on Display 0 10:57:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:57:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:57:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:57:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:57:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:57:24 INFO - Intel Iris: 10:57:24 INFO - Chipset Model: Intel Iris 10:57:24 INFO - Type: GPU 10:57:24 INFO - Bus: Built-In 10:57:24 INFO - VRAM (Dynamic, Max): 1536 MB 10:57:24 INFO - Vendor: Intel (0x8086) 10:57:24 INFO - Device ID: 0x0a2e 10:57:24 INFO - Revision ID: 0x0009 10:57:24 INFO - Displays: 10:57:24 INFO - Display: 10:57:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:57:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:57:24 INFO - Display Serial Number: 1600x1200 60 10:57:24 INFO - Main Display: Yes 10:57:24 INFO - Mirror: Off 10:57:24 INFO - Online: Yes 10:57:24 INFO - Rotation: Supported 10:57:24 INFO - Return code: 0 10:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:24 INFO - Python 2.7.3 10:57:24 INFO - Return code: 0 10:57:24 INFO - grabbing minidump binary from tooltool 10:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:24 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 0x100b10d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b08b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:24 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:57:24 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:57:24 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:57:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:24 INFO - Return code: 0 10:57:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:57:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:57:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:24 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/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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:57:24 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/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --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:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9rjnEHLaN/Render', 10:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:24 INFO - 'HOME': '/Users/cltbld', 10:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:24 INFO - 'LOGNAME': 'cltbld', 10:57:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:24 INFO - 'MOZ_NO_REMOTE': '1', 10:57:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:24 INFO - 'NO_EM_RESTART': '1', 10:57:24 INFO - 'PAGER': '/bin/cat', 10:57:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:24 INFO - 'PWD': '/builds/slave/test', 10:57:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:24 INFO - 'SHELL': '/bin/bash', 10:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.emoHYJHWLQ/Listeners', 10:57:24 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 10:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:24 INFO - 'USER': 'cltbld', 10:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:24 INFO - 'XPC_FLAGS': '0x0', 10:57:24 INFO - 'XPC_SERVICE_NAME': '0', 10:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:24 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/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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:57:24 INFO - mozversion application_buildid: 20160822083415 10:57:24 INFO - mozversion application_changeset: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 10:57:24 INFO - mozversion application_display_name: Nightly 10:57:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:24 INFO - mozversion application_name: Firefox 10:57:24 INFO - mozversion application_remotingname: firefox 10:57:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:57:24 INFO - mozversion application_vendor: Mozilla 10:57:24 INFO - mozversion application_version: 51.0a1 10:57:24 INFO - mozversion platform_buildid: 20160822083415 10:57:24 INFO - mozversion platform_changeset: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 10:57:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:57:24 INFO - mozversion platform_version: 51.0a1 10:57:24 INFO - using testdate: 1471888644 10:57:24 INFO - actual date: 1471888644 10:57:24 INFO - starting webserver on 'localhost:49475' 10:57:24 INFO - SUITE-START | Running 2 tests 10:57:24 INFO - TEST-START | dromaeo_css 10:57:24 INFO - operating with platform_type : mac_ 10:57:24 INFO - Initialising browser for dromaeo_css test... 10:57:24 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpqDRrvn/profile http://localhost:49475/getInfo.html) 10:57:26 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 10:57:26 INFO - PROCESS | 1910 | colorDepth:24 10:57:26 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 10:57:26 INFO - PROCESS | 1910 | __metrics 10:57:26 INFO - PROCESS | 1910 | 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:57:26 INFO - PROCESS | 1910 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:27 INFO - TEST-INFO | 1910: exit 0 10:57:27 INFO - Browser initialized. 10:57:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:27 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpqDRrvn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:39 INFO - PROCESS | 1912 | RSS: Main: 228900864 10:57:39 INFO - PROCESS | 1912 | 10:58:30 INFO - PROCESS | 1912 | 1471888710947 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] 11:00:42 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49475/tests/dromaeo/cssquery-ext.html) 11:00:44 INFO - PROCESS | 1912 | RSS: Main: 368447488 11:00:44 INFO - PROCESS | 1912 | 11:03:47 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-ext.html (next: http://localhost:49475/tests/dromaeo/cssquery-jquery.html) 11:03:47 INFO - PROCESS | 1912 | RSS: Main: 371474432 11:03:47 INFO - PROCESS | 1912 | 11:06:49 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49475/tests/dromaeo/cssquery-mootools.html) 11:06:50 INFO - PROCESS | 1912 | RSS: Main: 337903616 11:06:50 INFO - PROCESS | 1912 | 11:09:52 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49475/tests/dromaeo/cssquery-prototype.html) 11:09:53 INFO - PROCESS | 1912 | RSS: Main: 342409216 11:09:53 INFO - PROCESS | 1912 | 11:12:56 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49475/tests/dromaeo/cssquery-yui.html) 11:12:57 INFO - PROCESS | 1912 | RSS: Main: 327827456 11:12:57 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-yui.html (next: http://localhost:49475/tests/dromaeo/cssquery-dojo.html) 11:16:00 INFO - PROCESS | 1912 | RSS: Main: 409157632 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | __start_tp_report 11:16:00 INFO - PROCESS | 1912 | _x_x_mozilla_page_load 11:16:00 INFO - PROCESS | 1912 | _x_x_mozilla_page_load_details 11:16:00 INFO - PROCESS | 1912 | |i|pagename|runs| 11:16:00 INFO - PROCESS | 1912 | |0;dojo.html;2737.2062101990423;3317.0546394277635;3332.3168750406153;3332.6334103248637;3334.9166270843234;5475.72621368931;5578.804741834031;5590.804321848736;5651.802186923458;5674.801381951627;5496.230527726111;5566.276384070075;5578.804741834037;5610.495055445009;5635.070213414792;5109.156989096813;5110.872228194306;5178.922316165261;5198.220266959967;5286.656367336111;5241.449647786984;5294.364676238837;5309.681419114846;5332.200169974496;5334.91997620036;5056.469070747556;5064.8480545583325;5101.82143624975;5148.639595228336;5224.764885580139;5126.512981266774;5147.819826306061;5152.355955505562;5212.765425555859;5217.58259339252;5151.021305951857;5156.329677141947;5173.249878767595;5201.531862132389;5203.8178663746585;5416;5504.174373843915;5612.747426365823;5625.6905870177125;5667.8583035424035;6056.091586262096;6232.657203853786;6243.87512249757;6249.906251406187;6267.780627678055;6268.279147898004;6324.08300796382;6335.176427064452;6336.714847831859;6336.904946425807;5620.156976453564;5683.232763576864;5746.02317606008;5819.068948968187;5834.620749651259;6342.873142537123;6354.682265886687;6364.936350636527;6366.267879193952;6388.265349484869;6112.205413296243;6116.633002019893;6133.202683651097;6149.046897730859;6150.169727086875;5985.311689155716;6152.938470615326;6155.969220153871;6272.40412160844;6283.874322513616;6036.305824830113;6063.9090413643835;6112.083187521907;6112.419320164578;6198.752049917953;6182.350853160443;6192.225971753531;6192.628442293477;6200.906986395207;6211.65835879031;4938.851834444972;4967.4784147664695;4973;4980.701157930535;4991.376077990251;3357.815320157366;3715.8142092895246;3723.478712980185;4331.870043898688;4436.26801577736;5591.692456914909;5688.288963879515;5692.544596432275;5701.942980570141;5704.201411802351;6293.685315734195;6305.747770089237;6311.842203944938;6317;6329.651869147149;5453.318335208099;5475.835724928259;5497;5591.07747221712;5657.010023245915;5319.175527793198;5363.570914326844;5368.1679339702405;5376.1666941623325;5437.374701909252;6306.653134077578;6315.179026726496;6332.113504109337;6335.746570137143;6339.5562310637815;6199.752009919553;6248.781292654735;6256.436920677161;6256.468200203034;6270.216222972129;6200;6234.251889773075;6242.28213755424;6248.094026366242;6304.779332723333;6171.228596425447;6185.505159587312;6190.0714892764645;6206.410391013027;6210.099535567227;6157.4458298753325;6258.186435763321;6283.151774510383;6287.119803227643;6288.779892703734;4344;5779.699567597257;5864.149698293638;6089.665068421279;6129.387061293835;6029.306629737636;6079.209702738793;6084.482818960261;6090.969545152246;6096;5878.94121058801;5881.73532191061;5886;5894.587378883437;5906.527477801679;5784.334801497714;5825.0679891217205;5846.503047240862;6096.542759292982;6104.298005729398;5806.5064469518875;5810.215620891295;5812.360640329645;5818.796342128006;5828.213191219301 11:16:00 INFO - PROCESS | 1912 | |1;ext.html;459.9586037256646;482.16825975192796;487.6342742942793;528.1549520766773;533.4372237289658;30778.230544236376;31349.686503134963;40092.99999999996;40656.18687626246;40838.18323633533;40007;42101.36847947283;42197.789011054905;42240.788796056055;42455.36316955248;9793.510324483765;9964.501774911261;9968.202543796478;9974.900250997505;9976;9847.606095756197;9948.5523151458;9954.452505112216;9966.451845148551;9969.252306077036;9913.454759988197;9965.103140717334;9966.800663986716;9968.102870741632;9973.152282056033;9895.950520247388;9947.154491868163;9954.253430992705;9954.303198776088;9957.153641940371;9853.162481189107;9942.751431214205;9949.950250248774;9965.551550180187;9986.700398988041;39873;40222.396664050066;40264.59073932398;40328.193436131114;40330.39504407407;3352.8658853645825;3441.3633477806684;3453.5165076889;3463.6363181865795;3553.4847447120283;30274.09177724672;30496.085117446513;30549.541756873663;30605.693943060505;30616.54075188874;3282.1302354875975;3315.784474009182;3331.3670402623425;3407.216340241758;3443.7589368744198;501666;504946;506952;507310;507701.99999999633;57183.42816571781;57417.712911436014;57584;57615;57655.69377224864;59730;59772.10341844876;59772.70113649404;59843;59883.80232395415;16130.838691612933;16364.936279141817;16373.590660233589;16377.42679006229;16394.09832459226;12789.552365667343;12867.549635762703;12870.099093063583;12886.162399444007;12887;14147.929260353632;15629.609259768597;15634.3746250151;15657.217139142997;15835.841641583436;4673.579377856009;5759.568032397503;6095.451409373089;6125.663088530085;6135.417135372132;821.4414198345182;909.1857570834608;964.7250533597891;987.1806400687556;1127.2391135983341;27483.45033099327;27486.17541473759;29733.851330743208;30060;30229.244268893013;815.4943934760487;1026.2662196529518;1060.3690803971624;1111.4109521953378;1151.7408583068743;11209.93505616965;14784.63038424048;14982.400703971936;14998.775018374734;15404.46084387041;574403;671777;675766;676759;677549.8367524492;54716.179257311174;54901.725491372286;54915.901681966134;54969;55091.72454137784;1226.791445454275;1269.936503174856;1348.3190988550916;1378.0422606288735;1402.2708191740442;22256.443588910406;25351.6197257045;28628.427431450837;28902.98839540606;30098.097057088322;48913.2663010048;49549.25676114789;49558;49640.503594963586;49662.25506617476;556220;558824;559135;559660;560894;22718.97764600564;25695.229143125736;26563.335916601467;26566;27223.727762722912;46989.355372563165;47224.05551889012;48038.759806200746;48171.75914120407;48569;38065.23869522649;38496.03759906025;38752.48442099897;38973;39995.80002099971;37518.624813751514;38373.808130959165;38826.80586597049;39190.80404597959;41150.58849411467;37334.25331493409;37909.81045094867;38085.85742427732;38088.619113808505;38568.228635427695;33128;33889.66110338865;34746.65253347434;34749.82625086858;34773.78291759776;25097.498050039263;25268.49463010693;25367.98528058931;25725.485490290463;25966.61050084288 11:16:00 INFO - PROCESS | 1912 | |2;jquery.html;350.12643454580825;370.1874385723335;372.72232187020666;381.65650914177246;400.45738024976157;14748.852511474883;15155.62110947227;20479;20542.69185962212;20839.0578022022;19189.520261993457;20138.39584812458;20257.696134557995;20323.59352812943;20536.8973155134;5229.7385130743505;5837.09525023622;6099.542534309944;6102.0541816018585;6110.633361998294;5963.493103086243;6109.419605137505;6114.510839132859;6119.479844213247;6122.938770612282;5804.245448091742;5865.736041878125;5932.822015339547;6058.757649694007;6058.818235452922;5896.941030589682;5929.229200203946;5936.673482958436;5939.07944268639;5940.049592065248;4925.26121081837;5111.744412779346;5147.665401748912;5171.612129090333;5173.327467429248;25222.873885630455;25239.990400383962;25296.747032529805;25332.860021299086;25612.871935640203;2404.5311164322966;2410.192585483865;2865.6704478984766;3079.538069289602;3170.826794086203;9702.854457183148;10264.94867525665;10355.17158627308;10404.791904161875;10419.21855860806;1796.6047469556677;1843.7326587644716;1851.333519932823;1884.3969929622526;1923.538350795813;115706.84293157129;128998.35500822529;131126;132597.3370133143;134367.65632343746;9293.628254869729;10895.295599496209;10927.67216983476;11380.487878045342;11390.202685812079;14264.643383915485;14283.78574321386;14284.50004249867;14300.713985720227;14302.785458218135;8145.551994640233;8350.08149103598;8384.790380240422;8508.021577518664;8544.359173062045;8372.372072094617;8373.95813020931;8377.246047855722;8552.40133190683;8553.401261911731;4396.780160992002;4398.142362239332;4398.956010439919;4403.669724770655;4476.574725401147;1543.5755167329075;1894.6116046210493;1894.9242030318908;1899.6865517189508;1901.5056085417891;796.9641366138537;890.2077151335317;935.1157417802997;950.8763860698203;973.2068364283086;19529.511762205773;20296.289629862884;20307.492312692004;20565;20687.862167580926;903.8870141232346;917.3991035871514;938.8216238914584;968.6561270748782;993.7913038262046;9976.501174941224;10148.340357876861;10711.78576428467;10715.571377144826;10717.678469645924;590392.384304623;615983.6803264;623261;633446;637766;121883;122638;126209;126775.36612316879;128624.71375286314;956.8086382723483;967.8790151231096;1002.929794914349;1026.3995562595817;1028.598846449885;17463.650726985135;18037;18143.818561814212;18153.27386904509;18255.1785169665;52539.737301313246;53051;54029.729851350494;54488.45511544992;54607.26963651881;71546.12992570917;72173.63913180401;74621;75795;75901;7785;8084.919150808417;8161.224683655043;8180.550069746221;8441.451305665112;10624.84062739044;12092.697682558006;12269.69325766863;12857.871421285667;13274.402651880882;10947.50736216888;11435.142364322543;11451.31292122442;11508.309501429942;11661.300321980709;11171.05046071093;11218.943905280421;11421.257618254787;11544.307341559534;11636.53453861836;11152.16358773079;11315.830262546233;11577;11628.186026978368;11721.706957325794;5555.472230138131;6941.687624056828;7537.397008239218;7997.440179187401;8237.176282371955;10544.472776361305;10987.230893837674;11120.388378638929;11446.542138314375;11617.883821162019 11:16:00 INFO - PROCESS | 1912 | |3;mootools.html;1341.0679577693506;1478.4234148682017;1522.8857835662327;1651.686179625871;1826.2147276671035;7763.728269510569;8363.163683631634;8569.614367353477;8662.436941598808;8682.220144870302;8362.372822038342;8531.530765807878;8532.402731808776;8653.177948094937;8663.826723465543;2348.859068455898;2394.964075538868;2396.077510158584;2403.122860156039;2404.6753688252124;2332.4285550040263;2377.084822343393;2382.6664267002634;2384.3919800450863;2384.6303822907475;2324.941876453085;2354.846934949223;2359.3511784259294;2372.822038347122;2375.6080246759266;2314.664373665809;2351.576716191085;2357.222116701493;2363.0429675981254;2365.1249037855932;2323.8373313868037;2348.272035668931;2353.176388264111;2354.0466111224982;2354.8822558872157;8618.827623447496;8659.220670139655;8693.000304964948;8694.956525217334;8697.608607612672;5210.739463026834;5347.679139251657;5357.491038351351;5374.811881584164;5388.78444862205;3625.6918161956264;3641.3809652358896;3683.410654295327;3710.9814450927574;3715.665590096877;927.5084205371164;962.451402700461;1098;1106.9612563560318;1125.9155563332783;11294.491747871283;11311.264767790068;11465;11476.942615286871;11482;4606.608438282717;4642.767861606906;4805.111054454937;4824.445188803263;4828.61371090312;9884.901150988542;9887;9887.901120988841;9903.108720215216;9904.455254960902;5310.097283461821;5314.096603577324;5318.8936221276135;5319.494648008433;5323.228131920927;3874.3994680824517;4343.630791382705;4498.775061246924;4803.5916947059195;4860.513948605111;3893.9415908761393;3901.6098390160755;4016.9598304016586;4029.71791974559;4048.817803198863;1270.2061211742662;1290.4128621477205;1291.7803973324558;1301.4598941439385;1310.7771678814624;831.5260301628135;874.7900503879023;878.4729162502575;909.7998440343114;942.8491441369348;5984;6107.328193898667;6144.8771024579255;6206.689665516707;6323.656510248832;883.88067610873;898.793277546155;913.7167478081816;949.534727983297;1012.2155329619603;3872.4384964180035;3962.227365663726;4004.2992476316526;4064.6545043671026;4070.3487442009136;10366.844497332546;10719.946400268105;10729.195310351755;10736.624218152327;10739.677809665722;10607.363558186533;10683.679489615168;10697.251192416456;10702.73243168927;10719.303245289031;7675;8046.988252936766;8170.836583268301;8183.099859015503;8193.877091843628;5925.881482370242;6108.4807791338235;6134.202553667995;6138.421862817717;6173.56785025044;7616.771496855104;9830.75423114428;9913.206943444364;9965.651202207888;10022.599096036078;9702.633814783518;10148.949255253676;10194.082532572103;10223.437710925971;10235.539400726837;7375.37309328713;7452;7490.1386340571535;7563.168051514219;7566.016417865642;8153.8369232616205;8206.261436470746;8230.259276665129;8235.34117270605;8247.340212783083;7289.380402665833;7456.589887556236;7540.396768258416;7555.546667199986;7562.9252038003315;7206.531575447579;7298.56208627484;7350.889736653848;7404.518706284074;7549.660265287966;6856.554323968926;6993.510454268152;6996.440284777103;6997.965010174917;6998.335158159966;4967.82612608557;5023;5089.109405854035;5111.616628752784;5166.638335316492;4976.776045078052;4981.726005069756;5141.871453213699;5193.662411943212;5223.138182199895 11:16:00 INFO - PROCESS | 1912 | |4;prototype.html;283.61003620022467;292.7526240326924;299.93551386451907;302.3801207524574;302.97576193904484;4935.506449355063;5048.1670524363435;5078.771455284512;5132.538071573562;5199.3760748710165;4358.803853826577;4573.748443835588;4969.229769385742;5036.722980236085;5050.267711181886;3206.903792886217;3237.919052023695;3888.2806680764006;3914.2954268231706;3921.6470517653333;3615.4576813478056;3915.138669492707;3917.138229589486;3956.7536226088832;3984.3226651469176;3378.4256676365076;3514;3882.9127844203667;3904.1801221743467;3932.941005884914;3890.8794706884673;3893.4549163116903;3894.7663140211394;3912.374020156761;3914.5693973662874;2693.663292088489;2994.970050299491;3408.863645454204;3428.502867084284;3432.70821980132;4143.357779544175;4839.249916262949;4856.130139174968;4973.925391119136;5112.909672262175;4412.448443944507;4416.2713152329825;4419.823207071713;4429.889252768674;4483.820647174109;5257.737113144328;5260.158374660036;5271.077561426773;5283.599846040764;5299.959515586488;3161.5415764714216;3612.663314573598;3771.679407250387;3800.8669696560764;3813.6652171739947;4380.978095109536;4486.416765820455;5496.80761173357;5593.972030139864;5599.740058486808;3125.453045717036;3686.9262614747554;3689.870854520079;3709.239605880788;3745.4756334113245;3183.363327334542;3430.6740859618294;3770.5286839145106;3782.470454136423;3807.3908174691915;3705.7215260735;3734.6452087051684;4364.803583838735;4422.668299877458;4429.247028005247;4206.978965105216;5300.655457395257;5351.839444816662;5374.220737993047;5377.951299496561;1091.9344839309667;1194.9163558550817;1251.330538162079;1253.8056601226824;1287.0025730059278;746.2910235276509;755.5806527377248;831.0442990560904;863.8899014766121;885.2121611765534;4219.493660760729;4455.331700244924;4971.1797553404;5112.897742045138;5127.53852153308;5221.686698798008;5474.808381706701;5549.975263481412;5580.776768929198;5608.139848677204;4795.280707893844;4919.7540122993705;5027.321311622884;5049.949500505021;5103.362079740033;1940.5536726552689;1959.4911917823197;2219.0014493477674;2362.492064206204;2368.869712165813;4285.592868677533;4605.815767369335;4606;4628.791704373311;4726.905461890743;4288.442502474658;4590.678652494294;4599.816007359668;4632.768361581908;4673.3690951721765;4199.97100710328;4313.784310784511;4375.6808891287665;4681.742504162167;4738;3540.1857572758927;4070.430139780374;4457.175422546839;4459.777011149365;4533.320001999727;3759.548854137521;3889.4943657324366;4114.4034115052555;4359.520452750258;4481.068297695519;4078.3678529827926;4500.4149460571225;4505;4760.904781904412;4766.37755305963;2906.6193558059754;2931.018108933531;3017.487027205424;3265.412225799284;3273.72324793326;3833.7189372323423;4251.4685664291965;4484.75333856641;4502.221622459176;4609.801451622535;3965.730966090823;4785;4994.275830004556;5433.891322173614;5481.835544933659;4601.4248218972625;4603.033362993675;4898.730569818552;4958.685948223796;5436.836894893159;4535.6641329715885;5081.63887099114;5238.188080847474;5306.310179676618;5321.6540924839765;4340.392345071756;5332.68003919766;5401;5425.674459532441;5436.945630543644;4425.845095421773;5301.708406037705;5304.549113325411;5320.973395133;5323.30796996388 11:16:00 INFO - PROCESS | 1912 | |5;yui.html;714.5034201230145;725.314577724051;767.2557619109465;772.4284029817936;815.188887057378;15238.619034524128;16370.099644519547;16406.015639061665;16421;16440.26018829154;14796.926015369934;14951.177685227309;14959.177245251507;14965.925170374132;14978.925105374485;653.2618141500099;664.717495064598;675.0347003784586;807.422692774666;816.0411516468156;817.6361519123992;828.5981299069946;829.4898637338054;830.622066959535;830.6635812495949;879.9384043116985;880.3001613717079;880.6521424037502;880.8018195905902;882.0385779500343;875.3434923807145;876.1632640827994;876.2639382918316;876.3952872518006;876.9605367758498;512.784630455206;525.3275806967089;526.2921370756327;528.0916823064323;531.6172355903743;14401.063930844462;14944.62638434037;15030;15031.473898413504;15055.698886022219;14410.711785764332;14784.704305913929;14964.700705985819;15113.848861511355;15129.5461136165;11998.280103193749;12100.334481603508;12223;12242.204256723284;12282.38588070593;3745.213505163919;3780.4329350597354;3802.961970380316;3863.4011728182177;3864.9033774155873;111959;112369;113365.59903202835;115098.42450787693;115327;11336.43317834105;11604.30374177552;11666.76666466683;11700;11822.728951808496;23586.410339741644;23792.40518987039;23825;23832.285031449082;23866.522669546513;8036.879446808302;8075.232852879085;8137.389695772722;8182.67269309221;8225.383096267804;4459.777011149429;4502.684812063189;4529.705569137996;4600.7469589172915;4695.131400690883;3670.8531658733887;3754.2303827715255;3801.6008319126095;3802.16352402471;3805.124821291063;666.6466772610427;670.3062330487921;681.4786688183543;684.8938414545753;690.689189864563;613.8250598579473;635.7870113511933;655.3381085104079;662.1623646087703;698.7554355975368;9572.817362939106;9652.36925866339;9700.466474343979;9757.414555126716;9992.028953218383;500.44505983582667;567.8892615939852;617.8486270863667;624.188554878656;674.4503229867643;4307.612314891675;4448;4684.688267401044;4773.594244489188;4779.545943135397;111996;126426;129466;135366;139342;93140.53429732943;98005.01994979959;103634.48182759188;129248;130176.3491182538;63092.79175228845;71714.64142679253;95023.52488237515;96783;97562;9687.370320929398;9821.558029888529;10010.349327293703;10060.899391006289;10077.647282345082;59225.703871480364;61445.38554614576;62884;63287;65405;88608.5569572148;95971;96103.51948240215;97001.51499242459;100505.49747251217;13093.869061309266;13282.40229189708;13576.932115339756;13617.251051191883;13758.65603359924;14571.708565828836;14652.340644670801;15035.54893353201;15048.322825472662;15465.381384744935;11979.880201198224;13782.448702051806;14187.361568729639;14567.708645826811;14642.85357146415;7345.963270183829;13990.300484975915;14121.858781412055;14153;14576.927115364355;13972;14130.576082717535;14193.716125677634;14293.857061429253;14391.28043597795;10997.780044399227;11340.979311861642;11703.414829258674;11785.175037747274;11957.282563046245;11576.503482537182;11601.651950441501;11789.941050294694;11979.760404791681;12013.939930300643 11:16:00 INFO - PROCESS | 1912 | __end_tp_report 11:16:00 INFO - PROCESS | 1912 | __start_cc_report 11:16:00 INFO - PROCESS | 1912 | _x_x_mozilla_cycle_collect,1438 11:16:00 INFO - PROCESS | 1912 | __end_cc_report 11:16:00 INFO - PROCESS | 1912 | __startTimestamp1471889760911__endTimestamp 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | ------- Summary: start ------- 11:16:00 INFO - PROCESS | 1912 | Number of tests: 6 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | [#0] dojo.html Cycles:165 Average:5682.73 Median:5828.21 stddev:703.38 (12.1%) stddev-sans-first:666.51 11:16:00 INFO - PROCESS | 1912 | Values: 2737.2 3317.1 3332.3 3332.6 3334.9 5475.7 5578.8 5590.8 5651.8 5674.8 5496.2 5566.3 5578.8 5610.5 5635.1 5109.2 5110.9 5178.9 5198.2 5286.7 5241.4 5294.4 5309.7 5332.2 5334.9 5056.5 5064.8 5101.8 5148.6 5224.8 5126.5 5147.8 5152.4 5212.8 5217.6 5151.0 5156.3 5173.2 5201.5 5203.8 5416.0 5504.2 5612.7 5625.7 5667.9 6056.1 6232.7 6243.9 6249.9 6267.8 6268.3 6324.1 6335.2 6336.7 6336.9 5620.2 5683.2 5746.0 5819.1 5834.6 6342.9 6354.7 6364.9 6366.3 6388.3 6112.2 6116.6 6133.2 6149.0 6150.2 5985.3 6152.9 6156.0 6272.4 6283.9 6036.3 6063.9 6112.1 6112.4 6198.8 6182.4 6192.2 6192.6 6200.9 6211.7 4938.9 4967.5 4973.0 4980.7 4991.4 3357.8 3715.8 3723.5 4331.9 4436.3 5591.7 5688.3 5692.5 5701.9 5704.2 6293.7 6305.7 6311.8 6317.0 6329.7 5453.3 5475.8 5497.0 5591.1 5657.0 5319.2 5363.6 5368.2 5376.2 5437.4 6306.7 6315.2 6332.1 6335.7 6339.6 6199.8 6248.8 6256.4 6256.5 6270.2 6200.0 6234.3 6242.3 6248.1 6304.8 6171.2 6185.5 6190.1 6206.4 6210.1 6157.4 6258.2 6283.2 6287.1 6288.8 4344.0 5779.7 5864.1 6089.7 6129.4 6029.3 6079.2 6084.5 6091.0 6096.0 5878.9 5881.7 5886.0 5894.6 5906.5 5784.3 5825.1 5846.5 6096.5 6104.3 5806.5 5810.2 5812.4 5818.8 5828.2 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | [#1] ext.html Cycles:180 Average:70027.56 Median:40296.39 stddev:154350.78 (383.0%) stddev-sans-first:154695.39 11:16:00 INFO - PROCESS | 1912 | Values: 460.0 482.2 487.6 528.2 533.4 30778.2 31349.7 40093.0 40656.2 40838.2 40007.0 42101.4 42197.8 42240.8 42455.4 9793.5 9964.5 9968.2 9974.9 9976.0 9847.6 9948.6 9954.5 9966.5 9969.3 9913.5 9965.1 9966.8 9968.1 9973.2 9896.0 9947.2 9954.3 9954.3 9957.2 9853.2 9942.8 9950.0 9965.6 9986.7 39873.0 40222.4 40264.6 40328.2 40330.4 3352.9 3441.4 3453.5 3463.6 3553.5 30274.1 30496.1 30549.5 30605.7 30616.5 3282.1 3315.8 3331.4 3407.2 3443.8 501666.0 504946.0 506952.0 507310.0 507702.0 57183.4 57417.7 57584.0 57615.0 57655.7 59730.0 59772.1 59772.7 59843.0 59883.8 16130.8 16364.9 16373.6 16377.4 16394.1 12789.6 12867.5 12870.1 12886.2 12887.0 14147.9 15629.6 15634.4 15657.2 15835.8 4673.6 5759.6 6095.5 6125.7 6135.4 821.4 909.2 964.7 987.2 1127.2 27483.5 27486.2 29733.9 30060.0 30229.2 815.5 1026.3 1060.4 1111.4 1151.7 11209.9 14784.6 14982.4 14998.8 15404.5 574403.0 671777.0 675766.0 676759.0 677549.8 54716.2 54901.7 54915.9 54969.0 55091.7 1226.8 1269.9 1348.3 1378.0 1402.3 22256.4 25351.6 28628.4 28903.0 30098.1 48913.3 49549.3 49558.0 49640.5 49662.3 556220.0 558824.0 559135.0 559660.0 560894.0 22719.0 25695.2 26563.3 26566.0 27223.7 46989.4 47224.1 48038.8 48171.8 48569.0 38065.2 38496.0 38752.5 38973.0 39995.8 37518.6 38373.8 38826.8 39190.8 41150.6 37334.3 37909.8 38085.9 38088.6 38568.2 33128.0 33889.7 34746.7 34749.8 34773.8 25097.5 25268.5 25368.0 25725.5 25966.6 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | [#2] jquery.html Cycles:180 Average:35623.34 Median:25472.87 stddev:103517.66 (406.4%) stddev-sans-first:103774.18 11:16:00 INFO - PROCESS | 1912 | Values: 350.1 370.2 372.7 381.7 400.5 14748.9 15155.6 20479.0 20542.7 20839.1 19189.5 20138.4 20257.7 20323.6 20536.9 5229.7 5837.1 6099.5 6102.1 6110.6 5963.5 6109.4 6114.5 6119.5 6122.9 5804.2 5865.7 5932.8 6058.8 6058.8 5896.9 5929.2 5936.7 5939.1 5940.0 4925.3 5111.7 5147.7 5171.6 5173.3 25222.9 25240.0 25296.7 25332.9 25612.9 2404.5 2410.2 2865.7 3079.5 3170.8 9702.9 10264.9 10355.2 10404.8 10419.2 1796.6 1843.7 1851.3 1884.4 1923.5 115706.8 128998.4 131126.0 132597.3 134367.7 9293.6 10895.3 10927.7 11380.5 11390.2 14264.6 14283.8 14284.5 14300.7 14302.8 8145.6 8350.1 8384.8 8508.0 8544.4 8372.4 8374.0 8377.2 8552.4 8553.4 4396.8 4398.1 4399.0 4403.7 4476.6 1543.6 1894.6 1894.9 1899.7 1901.5 797.0 890.2 935.1 950.9 973.2 19529.5 20296.3 20307.5 20565.0 20687.9 903.9 917.4 938.8 968.7 993.8 9976.5 10148.3 10711.8 10715.6 10717.7 590392.4 615983.7 623261.0 633446.0 637766.0 121883.0 122638.0 126209.0 126775.4 128624.7 956.8 967.9 1002.9 1026.4 1028.6 17463.7 18037.0 18143.8 18153.3 18255.2 52539.7 53051.0 54029.7 54488.5 54607.3 71546.1 72173.6 74621.0 75795.0 75901.0 7785.0 8084.9 8161.2 8180.6 8441.5 10624.8 12092.7 12269.7 12857.9 13274.4 10947.5 11435.1 11451.3 11508.3 11661.3 11171.1 11218.9 11421.3 11544.3 11636.5 11152.2 11315.8 11577.0 11628.2 11721.7 5555.5 6941.7 7537.4 7997.4 8237.2 10544.5 10987.2 11120.4 11446.5 11617.9 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | [#3] mootools.html Cycles:180 Average:5691.39 Median:5154.25 stddev:3148.72 (61.1%) stddev-sans-first:3140.57 11:16:00 INFO - PROCESS | 1912 | Values: 1341.1 1478.4 1522.9 1651.7 1826.2 7763.7 8363.2 8569.6 8662.4 8682.2 8362.4 8531.5 8532.4 8653.2 8663.8 2348.9 2395.0 2396.1 2403.1 2404.7 2332.4 2377.1 2382.7 2384.4 2384.6 2324.9 2354.8 2359.4 2372.8 2375.6 2314.7 2351.6 2357.2 2363.0 2365.1 2323.8 2348.3 2353.2 2354.0 2354.9 8618.8 8659.2 8693.0 8695.0 8697.6 5210.7 5347.7 5357.5 5374.8 5388.8 3625.7 3641.4 3683.4 3711.0 3715.7 927.5 962.5 1098.0 1107.0 1125.9 11294.5 11311.3 11465.0 11476.9 11482.0 4606.6 4642.8 4805.1 4824.4 4828.6 9884.9 9887.0 9887.9 9903.1 9904.5 5310.1 5314.1 5318.9 5319.5 5323.2 3874.4 4343.6 4498.8 4803.6 4860.5 3893.9 3901.6 4017.0 4029.7 4048.8 1270.2 1290.4 1291.8 1301.5 1310.8 831.5 874.8 878.5 909.8 942.8 5984.0 6107.3 6144.9 6206.7 6323.7 883.9 898.8 913.7 949.5 1012.2 3872.4 3962.2 4004.3 4064.7 4070.3 10366.8 10719.9 10729.2 10736.6 10739.7 10607.4 10683.7 10697.3 10702.7 10719.3 7675.0 8047.0 8170.8 8183.1 8193.9 5925.9 6108.5 6134.2 6138.4 6173.6 7616.8 9830.8 9913.2 9965.7 10022.6 9702.6 10148.9 10194.1 10223.4 10235.5 7375.4 7452.0 7490.1 7563.2 7566.0 8153.8 8206.3 8230.3 8235.3 8247.3 7289.4 7456.6 7540.4 7555.5 7562.9 7206.5 7298.6 7350.9 7404.5 7549.7 6856.6 6993.5 6996.4 6998.0 6998.3 4967.8 5023.0 5089.1 5111.6 5166.6 4976.8 4981.7 5141.9 5193.7 5223.1 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | [#4] prototype.html Cycles:180 Average:4075.91 Median:4442.61 stddev:1262.78 (28.4%) stddev-sans-first:1233.82 11:16:00 INFO - PROCESS | 1912 | Values: 283.6 292.8 299.9 302.4 303.0 4935.5 5048.2 5078.8 5132.5 5199.4 4358.8 4573.7 4969.2 5036.7 5050.3 3206.9 3237.9 3888.3 3914.3 3921.6 3615.5 3915.1 3917.1 3956.8 3984.3 3378.4 3514.0 3882.9 3904.2 3932.9 3890.9 3893.5 3894.8 3912.4 3914.6 2693.7 2995.0 3408.9 3428.5 3432.7 4143.4 4839.2 4856.1 4973.9 5112.9 4412.4 4416.3 4419.8 4429.9 4483.8 5257.7 5260.2 5271.1 5283.6 5300.0 3161.5 3612.7 3771.7 3800.9 3813.7 4381.0 4486.4 5496.8 5594.0 5599.7 3125.5 3686.9 3689.9 3709.2 3745.5 3183.4 3430.7 3770.5 3782.5 3807.4 3705.7 3734.6 4364.8 4422.7 4429.2 4207.0 5300.7 5351.8 5374.2 5378.0 1091.9 1194.9 1251.3 1253.8 1287.0 746.3 755.6 831.0 863.9 885.2 4219.5 4455.3 4971.2 5112.9 5127.5 5221.7 5474.8 5550.0 5580.8 5608.1 4795.3 4919.8 5027.3 5049.9 5103.4 1940.6 1959.5 2219.0 2362.5 2368.9 4285.6 4605.8 4606.0 4628.8 4726.9 4288.4 4590.7 4599.8 4632.8 4673.4 4200.0 4313.8 4375.7 4681.7 4738.0 3540.2 4070.4 4457.2 4459.8 4533.3 3759.5 3889.5 4114.4 4359.5 4481.1 4078.4 4500.4 4505.0 4760.9 4766.4 2906.6 2931.0 3017.5 3265.4 3273.7 3833.7 4251.5 4484.8 4502.2 4609.8 3965.7 4785.0 4994.3 5433.9 5481.8 4601.4 4603.0 4898.7 4958.7 5436.8 4535.7 5081.6 5238.2 5306.3 5321.7 4340.4 5332.7 5401.0 5425.7 5436.9 4425.8 5301.7 5304.5 5321.0 5323.3 11:16:00 INFO - PROCESS | 1912 | 11:16:00 INFO - PROCESS | 1912 | [#5] yui.html Cycles:180 Average:23556.94 Median:3801.88 stddev:35808.46 (941.9%) stddev-sans-first:35867.83 11:16:00 INFO - PROCESS | 1912 | Values: 714.5 725.3 767.3 772.4 815.2 15238.6 16370.1 16406.0 16421.0 16440.3 14796.9 14951.2 14959.2 14965.9 14978.9 653.3 664.7 675.0 807.4 816.0 817.6 828.6 829.5 830.6 830.7 879.9 880.3 880.7 880.8 882.0 875.3 876.2 876.3 876.4 877.0 512.8 525.3 526.3 528.1 531.6 14401.1 14944.6 15030.0 15031.5 15055.7 14410.7 14784.7 14964.7 15113.8 15129.5 11998.3 12100.3 12223.0 12242.2 12282.4 3745.2 3780.4 3803.0 3863.4 3864.9 111959.0 112369.0 113365.6 115098.4 115327.0 11336.4 11604.3 11666.8 11700.0 11822.7 23586.4 23792.4 23825.0 23832.3 23866.5 8036.9 8075.2 8137.4 8182.7 8225.4 4459.8 4502.7 4529.7 4600.7 4695.1 3670.9 3754.2 3801.6 3802.2 3805.1 666.6 670.3 681.5 684.9 690.7 613.8 635.8 655.3 662.2 698.8 9572.8 9652.4 9700.5 9757.4 9992.0 500.4 567.9 617.8 624.2 674.5 4307.6 4448.0 4684.7 4773.6 4779.5 111996.0 126426.0 129466.0 135366.0 139342.0 93140.5 98005.0 103634.5 129248.0 130176.3 63092.8 71714.6 95023.5 96783.0 97562.0 9687.4 9821.6 10010.3 10060.9 10077.6 59225.7 61445.4 62884.0 63287.0 65405.0 88608.6 95971.0 96103.5 97001.5 100505.5 13093.9 13282.4 13576.9 13617.3 13758.7 14571.7 14652.3 15035.5 15048.3 15465.4 11979.9 13782.4 14187.4 14567.7 14642.9 7346.0 13990.3 14121.9 14153.0 14576.9 13972.0 14130.6 14193.7 14293.9 14391.3 10997.8 11341.0 11703.4 11785.2 11957.3 11576.5 11601.7 11789.9 11979.8 12013.9 11:16:00 INFO - PROCESS | 1912 | -------- Summary: end -------- 11:16:00 INFO - PROCESS | 1912 | 11:16:01 INFO - TEST-INFO | 1912: exit 0 11:16:01 INFO - TEST-OK | dromaeo_css | took 1117104ms 11:16:01 INFO - TEST-START | kraken 11:16:01 INFO - operating with platform_type : mac_ 11:16:01 INFO - Initialising browser for kraken test... 11:16:01 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpRBbloW/profile http://localhost:49475/getInfo.html) 11:16:04 INFO - PROCESS | 1919 | __metrics Screen width/height:1600/1200 11:16:04 INFO - PROCESS | 1919 | colorDepth:24 11:16:04 INFO - PROCESS | 1919 | Browser inner width/height: 1024/689 11:16:04 INFO - PROCESS | 1919 | __metrics 11:16:04 INFO - PROCESS | 1919 | 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" 11:16:04 INFO - PROCESS | 1919 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:04 INFO - TEST-INFO | 1919: exit 0 11:16:04 INFO - Browser initialized. 11:16:04 INFO - Running cycle 1/1 for kraken test... 11:16:04 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpRBbloW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:16 INFO - PROCESS | 1920 | RSS: Main: 228651008 11:16:16 INFO - PROCESS | 1920 | 11:16:19 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:20 INFO - PROCESS | 1920 | RSS: Main: 293703680 11:16:20 INFO - PROCESS | 1920 | 11:16:23 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-dft) 11:16:23 INFO - PROCESS | 1920 | RSS: Main: 295010304 11:16:23 INFO - PROCESS | 1920 | 11:16:27 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-fft) 11:16:27 INFO - PROCESS | 1920 | RSS: Main: 379052032 11:16:27 INFO - PROCESS | 1920 | 11:16:30 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-oscillator) 11:16:30 INFO - PROCESS | 1920 | RSS: Main: 281485312 11:16:30 INFO - PROCESS | 1920 | 11:16:32 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:33 INFO - PROCESS | 1920 | RSS: Main: 285069312 11:16:33 INFO - PROCESS | 1920 | 11:16:36 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49475/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:36 INFO - PROCESS | 1920 | RSS: Main: 323432448 11:16:36 INFO - PROCESS | 1920 | 11:16:39 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49475/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:40 INFO - PROCESS | 1920 | RSS: Main: 325283840 11:16:40 INFO - PROCESS | 1920 | 11:16:43 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49475/tests/kraken/driver.html?testName=json-parse-financial) 11:16:43 INFO - PROCESS | 1920 | RSS: Main: 323641344 11:16:43 INFO - PROCESS | 1920 | 11:16:45 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:46 INFO - PROCESS | 1920 | RSS: Main: 301965312 11:16:46 INFO - PROCESS | 1920 | 11:16:47 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:48 INFO - PROCESS | 1920 | RSS: Main: 301850624 11:16:48 INFO - PROCESS | 1920 | 11:16:50 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:51 INFO - PROCESS | 1920 | RSS: Main: 308428800 11:16:51 INFO - PROCESS | 1920 | 11:16:54 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:55 INFO - PROCESS | 1920 | RSS: Main: 316137472 11:16:55 INFO - PROCESS | 1920 | 11:16:58 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:58 INFO - PROCESS | 1920 | RSS: Main: 318726144 11:16:58 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49475/tests/kraken/driver.html?testName=ai-astar) 11:17:00 INFO - PROCESS | 1920 | RSS: Main: 362479616 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | __start_tp_report 11:17:00 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 11:17:00 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 11:17:00 INFO - PROCESS | 1920 | |i|pagename|runs| 11:17:00 INFO - PROCESS | 1920 | |0;ai-astar;98;113;107;112;115;113;116;113;111;112 11:17:00 INFO - PROCESS | 1920 | |1;audio-beat-detection;138;108;155;193;107;130;128;107;158;106 11:17:00 INFO - PROCESS | 1920 | |2;audio-dft;185;186;185;187;183;185;184;185;182;185 11:17:00 INFO - PROCESS | 1920 | |3;audio-fft;103;104;107;94;49;73;83;113;116;58 11:17:00 INFO - PROCESS | 1920 | |4;audio-oscillator;83;87;129;70;74;72;115;70;68;115 11:17:00 INFO - PROCESS | 1920 | |5;imaging-gaussian-blur;94;131;116;88;89;86;90;86;91;85 11:17:00 INFO - PROCESS | 1920 | |6;imaging-darkroom;94;94;94;105;94;94;95;95;94;111 11:17:00 INFO - PROCESS | 1920 | |7;imaging-desaturate;84;85;83;85;84;85;86;85;84;85 11:17:00 INFO - PROCESS | 1920 | |8;json-parse-financial;56;55;56;56;56;57;56;55;54;65 11:17:00 INFO - PROCESS | 1920 | |9;json-stringify-tinderbox;68;65;67;78;77;73;70;71;70;72 11:17:00 INFO - PROCESS | 1920 | |10;stanford-crypto-aes;86;88;86;86;88;87;86;86;90;85 11:17:00 INFO - PROCESS | 1920 | |11;stanford-crypto-ccm;139;138;148;148;149;141;137;124;230;151 11:17:00 INFO - PROCESS | 1920 | |12;stanford-crypto-pbkdf2;168;168;169;162;151;233;209;168;167;168 11:17:00 INFO - PROCESS | 1920 | |13;stanford-crypto-sha256-iterative;68;66;68;67;68;67;68;67;65;67 11:17:00 INFO - PROCESS | 1920 | __end_tp_report 11:17:00 INFO - PROCESS | 1920 | __start_cc_report 11:17:00 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,2149 11:17:00 INFO - PROCESS | 1920 | __end_cc_report 11:17:00 INFO - PROCESS | 1920 | __startTimestamp1471889820656__endTimestamp 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | ------- Summary: start ------- 11:17:00 INFO - PROCESS | 1920 | Number of tests: 14 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:5.16 (4.6%) stddev-sans-first:2.55 11:17:00 INFO - PROCESS | 1920 | Values: 98.0 113.0 107.0 112.0 115.0 113.0 116.0 113.0 111.0 112.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:134.00 stddev:28.82 (21.5%) stddev-sans-first:30.51 11:17:00 INFO - PROCESS | 1920 | Values: 138.0 108.0 155.0 193.0 107.0 130.0 128.0 107.0 158.0 106.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.42 (0.8%) stddev-sans-first:1.50 11:17:00 INFO - PROCESS | 1920 | Values: 185.0 186.0 185.0 187.0 183.0 185.0 184.0 185.0 182.0 185.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#3] audio-fft Cycles:10 Average:90.00 Median:53.50 stddev:23.38 (43.7%) stddev-sans-first:24.32 11:17:00 INFO - PROCESS | 1920 | Values: 103.0 104.0 107.0 94.0 49.0 73.0 83.0 113.0 116.0 58.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:71.00 stddev:22.76 (32.1%) stddev-sans-first:24.06 11:17:00 INFO - PROCESS | 1920 | Values: 83.0 87.0 129.0 70.0 74.0 72.0 115.0 70.0 68.0 115.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:88.50 stddev:15.36 (17.4%) stddev-sans-first:16.28 11:17:00 INFO - PROCESS | 1920 | Values: 94.0 131.0 116.0 88.0 89.0 86.0 90.0 86.0 91.0 85.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:94.00 stddev:5.98 (6.4%) stddev-sans-first:6.24 11:17:00 INFO - PROCESS | 1920 | Values: 94.0 94.0 94.0 105.0 94.0 94.0 95.0 95.0 94.0 111.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.84 (1.0%) stddev-sans-first:0.87 11:17:00 INFO - PROCESS | 1920 | Values: 84.0 85.0 83.0 85.0 84.0 85.0 86.0 85.0 84.0 85.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.06 (5.5%) stddev-sans-first:3.24 11:17:00 INFO - PROCESS | 1920 | Values: 56.0 55.0 56.0 56.0 56.0 57.0 56.0 55.0 54.0 65.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.50 stddev:4.12 (5.8%) stddev-sans-first:4.22 11:17:00 INFO - PROCESS | 1920 | Values: 68.0 65.0 67.0 78.0 77.0 73.0 70.0 71.0 70.0 72.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:1.48 (1.7%) stddev-sans-first:1.54 11:17:00 INFO - PROCESS | 1920 | Values: 86.0 88.0 86.0 86.0 88.0 87.0 86.0 86.0 90.0 85.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:148.00 stddev:29.06 (19.6%) stddev-sans-first:30.52 11:17:00 INFO - PROCESS | 1920 | Values: 139.0 138.0 148.0 148.0 149.0 141.0 137.0 124.0 230.0 151.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:168.00 stddev:24.82 (14.8%) stddev-sans-first:26.14 11:17:00 INFO - PROCESS | 1920 | Values: 168.0 168.0 169.0 162.0 151.0 233.0 209.0 168.0 167.0 168.0 11:17:00 INFO - PROCESS | 1920 | 11:17:00 INFO - PROCESS | 1920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 11:17:00 INFO - PROCESS | 1920 | Values: 68.0 66.0 68.0 67.0 68.0 67.0 68.0 67.0 65.0 67.0 11:17:00 INFO - PROCESS | 1920 | -------- Summary: end -------- 11:17:00 INFO - PROCESS | 1920 | 11:17:01 INFO - TEST-INFO | 1920: exit 0 11:17:01 INFO - TEST-OK | kraken | took 59939ms 11:17:01 INFO - SUITE-END | took 1177s 11:17:01 INFO - Completed test suite (00:19:37) 11:17:01 INFO - javascript benchmark 11:17:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2737.2062101990423, 3317.0546394277635, 3332.3168750406153, 3332.6334103248637, 3334.9166270843234, 5475.72621368931, 5578.804741834031, 5590.804321848736, 5651.802186923458, 5674.801381951627, 5496.230527726111, 5566.276384070075, 5578.804741834037, 5610.495055445009, 5635.070213414792, 5109.156989096813, 5110.872228194306, 5178.922316165261, 5198.220266959967, 5286.656367336111, 5241.449647786984, 5294.364676238837, 5309.681419114846, 5332.200169974496, 5334.91997620036, 5056.469070747556, 5064.8480545583325, 5101.82143624975, 5148.639595228336, 5224.764885580139, 5126.512981266774, 5147.819826306061, 5152.355955505562, 5212.765425555859, 5217.58259339252, 5151.021305951857, 5156.329677141947, 5173.249878767595, 5201.531862132389, 5203.8178663746585, 5416.0, 5504.174373843915, 5612.747426365823, 5625.6905870177125, 5667.8583035424035, 6056.091586262096, 6232.657203853786, 6243.87512249757, 6249.906251406187, 6267.780627678055, 6268.279147898004, 6324.08300796382, 6335.176427064452, 6336.714847831859, 6336.904946425807, 5620.156976453564, 5683.232763576864, 5746.02317606008, 5819.068948968187, 5834.620749651259, 6342.873142537123, 6354.682265886687, 6364.936350636527, 6366.267879193952, 6388.265349484869, 6112.205413296243, 6116.633002019893, 6133.202683651097, 6149.046897730859, 6150.169727086875, 5985.311689155716, 6152.938470615326, 6155.969220153871, 6272.40412160844, 6283.874322513616, 6036.305824830113, 6063.9090413643835, 6112.083187521907, 6112.419320164578, 6198.752049917953, 6182.350853160443, 6192.225971753531, 6192.628442293477, 6200.906986395207, 6211.65835879031, 4938.851834444972, 4967.4784147664695, 4973.0, 4980.701157930535, 4991.376077990251, 3357.815320157366, 3715.8142092895246, 3723.478712980185, 4331.870043898688, 4436.26801577736, 5591.692456914909, 5688.288963879515, 5692.544596432275, 5701.942980570141, 5704.201411802351, 6293.685315734195, 6305.747770089237, 6311.842203944938, 6317.0, 6329.651869147149, 5453.318335208099, 5475.835724928259, 5497.0, 5591.07747221712, 5657.010023245915, 5319.175527793198, 5363.570914326844, 5368.1679339702405, 5376.1666941623325, 5437.374701909252, 6306.653134077578, 6315.179026726496, 6332.113504109337, 6335.746570137143, 6339.5562310637815, 6199.752009919553, 6248.781292654735, 6256.436920677161, 6256.468200203034, 6270.216222972129, 6200.0, 6234.251889773075, 6242.28213755424, 6248.094026366242, 6304.779332723333, 6171.228596425447, 6185.505159587312, 6190.0714892764645, 6206.410391013027, 6210.099535567227, 6157.4458298753325, 6258.186435763321, 6283.151774510383, 6287.119803227643, 6288.779892703734, 4344.0, 5779.699567597257, 5864.149698293638, 6089.665068421279, 6129.387061293835, 6029.306629737636, 6079.209702738793, 6084.482818960261, 6090.969545152246, 6096.0, 5878.94121058801, 5881.73532191061, 5886.0, 5894.587378883437, 5906.527477801679, 5784.334801497714, 5825.0679891217205, 5846.503047240862, 6096.542759292982, 6104.298005729398, 5806.5064469518875, 5810.215620891295, 5812.360640329645, 5818.796342128006, 5828.213191219301], "value": 5632.6596499726265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.9586037256646, 482.16825975192796, 487.6342742942793, 528.1549520766773, 533.4372237289658, 30778.230544236376, 31349.686503134963, 40092.99999999996, 40656.18687626246, 40838.18323633533, 40007.0, 42101.36847947283, 42197.789011054905, 42240.788796056055, 42455.36316955248, 9793.510324483765, 9964.501774911261, 9968.202543796478, 9974.900250997505, 9976.0, 9847.606095756197, 9948.5523151458, 9954.452505112216, 9966.451845148551, 9969.252306077036, 9913.454759988197, 9965.103140717334, 9966.800663986716, 9968.102870741632, 9973.152282056033, 9895.950520247388, 9947.154491868163, 9954.253430992705, 9954.303198776088, 9957.153641940371, 9853.162481189107, 9942.751431214205, 9949.950250248774, 9965.551550180187, 9986.700398988041, 39873.0, 40222.396664050066, 40264.59073932398, 40328.193436131114, 40330.39504407407, 3352.8658853645825, 3441.3633477806684, 3453.5165076889, 3463.6363181865795, 3553.4847447120283, 30274.09177724672, 30496.085117446513, 30549.541756873663, 30605.693943060505, 30616.54075188874, 3282.1302354875975, 3315.784474009182, 3331.3670402623425, 3407.216340241758, 3443.7589368744198, 501666.0, 504946.0, 506952.0, 507310.0, 507701.99999999633, 57183.42816571781, 57417.712911436014, 57584.0, 57615.0, 57655.69377224864, 59730.0, 59772.10341844876, 59772.70113649404, 59843.0, 59883.80232395415, 16130.838691612933, 16364.936279141817, 16373.590660233589, 16377.42679006229, 16394.09832459226, 12789.552365667343, 12867.549635762703, 12870.099093063583, 12886.162399444007, 12887.0, 14147.929260353632, 15629.609259768597, 15634.3746250151, 15657.217139142997, 15835.841641583436, 4673.579377856009, 5759.568032397503, 6095.451409373089, 6125.663088530085, 6135.417135372132, 821.4414198345182, 909.1857570834608, 964.7250533597891, 987.1806400687556, 1127.2391135983341, 27483.45033099327, 27486.17541473759, 29733.851330743208, 30060.0, 30229.244268893013, 815.4943934760487, 1026.2662196529518, 1060.3690803971624, 1111.4109521953378, 1151.7408583068743, 11209.93505616965, 14784.63038424048, 14982.400703971936, 14998.775018374734, 15404.46084387041, 574403.0, 671777.0, 675766.0, 676759.0, 677549.8367524492, 54716.179257311174, 54901.725491372286, 54915.901681966134, 54969.0, 55091.72454137784, 1226.791445454275, 1269.936503174856, 1348.3190988550916, 1378.0422606288735, 1402.2708191740442, 22256.443588910406, 25351.6197257045, 28628.427431450837, 28902.98839540606, 30098.097057088322, 48913.2663010048, 49549.25676114789, 49558.0, 49640.503594963586, 49662.25506617476, 556220.0, 558824.0, 559135.0, 559660.0, 560894.0, 22718.97764600564, 25695.229143125736, 26563.335916601467, 26566.0, 27223.727762722912, 46989.355372563165, 47224.05551889012, 48038.759806200746, 48171.75914120407, 48569.0, 38065.23869522649, 38496.03759906025, 38752.48442099897, 38973.0, 39995.80002099971, 37518.624813751514, 38373.808130959165, 38826.80586597049, 39190.80404597959, 41150.58849411467, 37334.25331493409, 37909.81045094867, 38085.85742427732, 38088.619113808505, 38568.228635427695, 33128.0, 33889.66110338865, 34746.65253347434, 34749.82625086858, 34773.78291759776, 25097.498050039263, 25268.49463010693, 25367.98528058931, 25725.485490290463, 25966.61050084288], "value": 19565.754783679276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.12643454580825, 370.1874385723335, 372.72232187020666, 381.65650914177246, 400.45738024976157, 14748.852511474883, 15155.62110947227, 20479.0, 20542.69185962212, 20839.0578022022, 19189.520261993457, 20138.39584812458, 20257.696134557995, 20323.59352812943, 20536.8973155134, 5229.7385130743505, 5837.09525023622, 6099.542534309944, 6102.0541816018585, 6110.633361998294, 5963.493103086243, 6109.419605137505, 6114.510839132859, 6119.479844213247, 6122.938770612282, 5804.245448091742, 5865.736041878125, 5932.822015339547, 6058.757649694007, 6058.818235452922, 5896.941030589682, 5929.229200203946, 5936.673482958436, 5939.07944268639, 5940.049592065248, 4925.26121081837, 5111.744412779346, 5147.665401748912, 5171.612129090333, 5173.327467429248, 25222.873885630455, 25239.990400383962, 25296.747032529805, 25332.860021299086, 25612.871935640203, 2404.5311164322966, 2410.192585483865, 2865.6704478984766, 3079.538069289602, 3170.826794086203, 9702.854457183148, 10264.94867525665, 10355.17158627308, 10404.791904161875, 10419.21855860806, 1796.6047469556677, 1843.7326587644716, 1851.333519932823, 1884.3969929622526, 1923.538350795813, 115706.84293157129, 128998.35500822529, 131126.0, 132597.3370133143, 134367.65632343746, 9293.628254869729, 10895.295599496209, 10927.67216983476, 11380.487878045342, 11390.202685812079, 14264.643383915485, 14283.78574321386, 14284.50004249867, 14300.713985720227, 14302.785458218135, 8145.551994640233, 8350.08149103598, 8384.790380240422, 8508.021577518664, 8544.359173062045, 8372.372072094617, 8373.95813020931, 8377.246047855722, 8552.40133190683, 8553.401261911731, 4396.780160992002, 4398.142362239332, 4398.956010439919, 4403.669724770655, 4476.574725401147, 1543.5755167329075, 1894.6116046210493, 1894.9242030318908, 1899.6865517189508, 1901.5056085417891, 796.9641366138537, 890.2077151335317, 935.1157417802997, 950.8763860698203, 973.2068364283086, 19529.511762205773, 20296.289629862884, 20307.492312692004, 20565.0, 20687.862167580926, 903.8870141232346, 917.3991035871514, 938.8216238914584, 968.6561270748782, 993.7913038262046, 9976.501174941224, 10148.340357876861, 10711.78576428467, 10715.571377144826, 10717.678469645924, 590392.384304623, 615983.6803264, 623261.0, 633446.0, 637766.0, 121883.0, 122638.0, 126209.0, 126775.36612316879, 128624.71375286314, 956.8086382723483, 967.8790151231096, 1002.929794914349, 1026.3995562595817, 1028.598846449885, 17463.650726985135, 18037.0, 18143.818561814212, 18153.27386904509, 18255.1785169665, 52539.737301313246, 53051.0, 54029.729851350494, 54488.45511544992, 54607.26963651881, 71546.12992570917, 72173.63913180401, 74621.0, 75795.0, 75901.0, 7785.0, 8084.919150808417, 8161.224683655043, 8180.550069746221, 8441.451305665112, 10624.84062739044, 12092.697682558006, 12269.69325766863, 12857.871421285667, 13274.402651880882, 10947.50736216888, 11435.142364322543, 11451.31292122442, 11508.309501429942, 11661.300321980709, 11171.05046071093, 11218.943905280421, 11421.257618254787, 11544.307341559534, 11636.53453861836, 11152.16358773079, 11315.830262546233, 11577.0, 11628.186026978368, 11721.706957325794, 5555.472230138131, 6941.687624056828, 7537.397008239218, 7997.440179187401, 8237.176282371955, 10544.472776361305, 10987.230893837674, 11120.388378638929, 11446.542138314375, 11617.883821162019], "value": 9510.97686117119, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.0679577693506, 1478.4234148682017, 1522.8857835662327, 1651.686179625871, 1826.2147276671035, 7763.728269510569, 8363.163683631634, 8569.614367353477, 8662.436941598808, 8682.220144870302, 8362.372822038342, 8531.530765807878, 8532.402731808776, 8653.177948094937, 8663.826723465543, 2348.859068455898, 2394.964075538868, 2396.077510158584, 2403.122860156039, 2404.6753688252124, 2332.4285550040263, 2377.084822343393, 2382.6664267002634, 2384.3919800450863, 2384.6303822907475, 2324.941876453085, 2354.846934949223, 2359.3511784259294, 2372.822038347122, 2375.6080246759266, 2314.664373665809, 2351.576716191085, 2357.222116701493, 2363.0429675981254, 2365.1249037855932, 2323.8373313868037, 2348.272035668931, 2353.176388264111, 2354.0466111224982, 2354.8822558872157, 8618.827623447496, 8659.220670139655, 8693.000304964948, 8694.956525217334, 8697.608607612672, 5210.739463026834, 5347.679139251657, 5357.491038351351, 5374.811881584164, 5388.78444862205, 3625.6918161956264, 3641.3809652358896, 3683.410654295327, 3710.9814450927574, 3715.665590096877, 927.5084205371164, 962.451402700461, 1098.0, 1106.9612563560318, 1125.9155563332783, 11294.491747871283, 11311.264767790068, 11465.0, 11476.942615286871, 11482.0, 4606.608438282717, 4642.767861606906, 4805.111054454937, 4824.445188803263, 4828.61371090312, 9884.901150988542, 9887.0, 9887.901120988841, 9903.108720215216, 9904.455254960902, 5310.097283461821, 5314.096603577324, 5318.8936221276135, 5319.494648008433, 5323.228131920927, 3874.3994680824517, 4343.630791382705, 4498.775061246924, 4803.5916947059195, 4860.513948605111, 3893.9415908761393, 3901.6098390160755, 4016.9598304016586, 4029.71791974559, 4048.817803198863, 1270.2061211742662, 1290.4128621477205, 1291.7803973324558, 1301.4598941439385, 1310.7771678814624, 831.5260301628135, 874.7900503879023, 878.4729162502575, 909.7998440343114, 942.8491441369348, 5984.0, 6107.328193898667, 6144.8771024579255, 6206.689665516707, 6323.656510248832, 883.88067610873, 898.793277546155, 913.7167478081816, 949.534727983297, 1012.2155329619603, 3872.4384964180035, 3962.227365663726, 4004.2992476316526, 4064.6545043671026, 4070.3487442009136, 10366.844497332546, 10719.946400268105, 10729.195310351755, 10736.624218152327, 10739.677809665722, 10607.363558186533, 10683.679489615168, 10697.251192416456, 10702.73243168927, 10719.303245289031, 7675.0, 8046.988252936766, 8170.836583268301, 8183.099859015503, 8193.877091843628, 5925.881482370242, 6108.4807791338235, 6134.202553667995, 6138.421862817717, 6173.56785025044, 7616.771496855104, 9830.75423114428, 9913.206943444364, 9965.651202207888, 10022.599096036078, 9702.633814783518, 10148.949255253676, 10194.082532572103, 10223.437710925971, 10235.539400726837, 7375.37309328713, 7452.0, 7490.1386340571535, 7563.168051514219, 7566.016417865642, 8153.8369232616205, 8206.261436470746, 8230.259276665129, 8235.34117270605, 8247.340212783083, 7289.380402665833, 7456.589887556236, 7540.396768258416, 7555.546667199986, 7562.9252038003315, 7206.531575447579, 7298.56208627484, 7350.889736653848, 7404.518706284074, 7549.660265287966, 6856.554323968926, 6993.510454268152, 6996.440284777103, 6997.965010174917, 6998.335158159966, 4967.82612608557, 5023.0, 5089.109405854035, 5111.616628752784, 5166.638335316492, 4976.776045078052, 4981.726005069756, 5141.871453213699, 5193.662411943212, 5223.138182199895], "value": 4584.814958551848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.61003620022467, 292.7526240326924, 299.93551386451907, 302.3801207524574, 302.97576193904484, 4935.506449355063, 5048.1670524363435, 5078.771455284512, 5132.538071573562, 5199.3760748710165, 4358.803853826577, 4573.748443835588, 4969.229769385742, 5036.722980236085, 5050.267711181886, 3206.903792886217, 3237.919052023695, 3888.2806680764006, 3914.2954268231706, 3921.6470517653333, 3615.4576813478056, 3915.138669492707, 3917.138229589486, 3956.7536226088832, 3984.3226651469176, 3378.4256676365076, 3514.0, 3882.9127844203667, 3904.1801221743467, 3932.941005884914, 3890.8794706884673, 3893.4549163116903, 3894.7663140211394, 3912.374020156761, 3914.5693973662874, 2693.663292088489, 2994.970050299491, 3408.863645454204, 3428.502867084284, 3432.70821980132, 4143.357779544175, 4839.249916262949, 4856.130139174968, 4973.925391119136, 5112.909672262175, 4412.448443944507, 4416.2713152329825, 4419.823207071713, 4429.889252768674, 4483.820647174109, 5257.737113144328, 5260.158374660036, 5271.077561426773, 5283.599846040764, 5299.959515586488, 3161.5415764714216, 3612.663314573598, 3771.679407250387, 3800.8669696560764, 3813.6652171739947, 4380.978095109536, 4486.416765820455, 5496.80761173357, 5593.972030139864, 5599.740058486808, 3125.453045717036, 3686.9262614747554, 3689.870854520079, 3709.239605880788, 3745.4756334113245, 3183.363327334542, 3430.6740859618294, 3770.5286839145106, 3782.470454136423, 3807.3908174691915, 3705.7215260735, 3734.6452087051684, 4364.803583838735, 4422.668299877458, 4429.247028005247, 4206.978965105216, 5300.655457395257, 5351.839444816662, 5374.220737993047, 5377.951299496561, 1091.9344839309667, 1194.9163558550817, 1251.330538162079, 1253.8056601226824, 1287.0025730059278, 746.2910235276509, 755.5806527377248, 831.0442990560904, 863.8899014766121, 885.2121611765534, 4219.493660760729, 4455.331700244924, 4971.1797553404, 5112.897742045138, 5127.53852153308, 5221.686698798008, 5474.808381706701, 5549.975263481412, 5580.776768929198, 5608.139848677204, 4795.280707893844, 4919.7540122993705, 5027.321311622884, 5049.949500505021, 5103.362079740033, 1940.5536726552689, 1959.4911917823197, 2219.0014493477674, 2362.492064206204, 2368.869712165813, 4285.592868677533, 4605.815767369335, 4606.0, 4628.791704373311, 4726.905461890743, 4288.442502474658, 4590.678652494294, 4599.816007359668, 4632.768361581908, 4673.3690951721765, 4199.97100710328, 4313.784310784511, 4375.6808891287665, 4681.742504162167, 4738.0, 3540.1857572758927, 4070.430139780374, 4457.175422546839, 4459.777011149365, 4533.320001999727, 3759.548854137521, 3889.4943657324366, 4114.4034115052555, 4359.520452750258, 4481.068297695519, 4078.3678529827926, 4500.4149460571225, 4505.0, 4760.904781904412, 4766.37755305963, 2906.6193558059754, 2931.018108933531, 3017.487027205424, 3265.412225799284, 3273.72324793326, 3833.7189372323423, 4251.4685664291965, 4484.75333856641, 4502.221622459176, 4609.801451622535, 3965.730966090823, 4785.0, 4994.275830004556, 5433.891322173614, 5481.835544933659, 4601.4248218972625, 4603.033362993675, 4898.730569818552, 4958.685948223796, 5436.836894893159, 4535.6641329715885, 5081.63887099114, 5238.188080847474, 5306.310179676618, 5321.6540924839765, 4340.392345071756, 5332.68003919766, 5401.0, 5425.674459532441, 5436.945630543644, 4425.845095421773, 5301.708406037705, 5304.549113325411, 5320.973395133, 5323.30796996388], "value": 3682.8176420825353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.5034201230145, 725.314577724051, 767.2557619109465, 772.4284029817936, 815.188887057378, 15238.619034524128, 16370.099644519547, 16406.015639061665, 16421.0, 16440.26018829154, 14796.926015369934, 14951.177685227309, 14959.177245251507, 14965.925170374132, 14978.925105374485, 653.2618141500099, 664.717495064598, 675.0347003784586, 807.422692774666, 816.0411516468156, 817.6361519123992, 828.5981299069946, 829.4898637338054, 830.622066959535, 830.6635812495949, 879.9384043116985, 880.3001613717079, 880.6521424037502, 880.8018195905902, 882.0385779500343, 875.3434923807145, 876.1632640827994, 876.2639382918316, 876.3952872518006, 876.9605367758498, 512.784630455206, 525.3275806967089, 526.2921370756327, 528.0916823064323, 531.6172355903743, 14401.063930844462, 14944.62638434037, 15030.0, 15031.473898413504, 15055.698886022219, 14410.711785764332, 14784.704305913929, 14964.700705985819, 15113.848861511355, 15129.5461136165, 11998.280103193749, 12100.334481603508, 12223.0, 12242.204256723284, 12282.38588070593, 3745.213505163919, 3780.4329350597354, 3802.961970380316, 3863.4011728182177, 3864.9033774155873, 111959.0, 112369.0, 113365.59903202835, 115098.42450787693, 115327.0, 11336.43317834105, 11604.30374177552, 11666.76666466683, 11700.0, 11822.728951808496, 23586.410339741644, 23792.40518987039, 23825.0, 23832.285031449082, 23866.522669546513, 8036.879446808302, 8075.232852879085, 8137.389695772722, 8182.67269309221, 8225.383096267804, 4459.777011149429, 4502.684812063189, 4529.705569137996, 4600.7469589172915, 4695.131400690883, 3670.8531658733887, 3754.2303827715255, 3801.6008319126095, 3802.16352402471, 3805.124821291063, 666.6466772610427, 670.3062330487921, 681.4786688183543, 684.8938414545753, 690.689189864563, 613.8250598579473, 635.7870113511933, 655.3381085104079, 662.1623646087703, 698.7554355975368, 9572.817362939106, 9652.36925866339, 9700.466474343979, 9757.414555126716, 9992.028953218383, 500.44505983582667, 567.8892615939852, 617.8486270863667, 624.188554878656, 674.4503229867643, 4307.612314891675, 4448.0, 4684.688267401044, 4773.594244489188, 4779.545943135397, 111996.0, 126426.0, 129466.0, 135366.0, 139342.0, 93140.53429732943, 98005.01994979959, 103634.48182759188, 129248.0, 130176.3491182538, 63092.79175228845, 71714.64142679253, 95023.52488237515, 96783.0, 97562.0, 9687.370320929398, 9821.558029888529, 10010.349327293703, 10060.899391006289, 10077.647282345082, 59225.703871480364, 61445.38554614576, 62884.0, 63287.0, 65405.0, 88608.5569572148, 95971.0, 96103.51948240215, 97001.51499242459, 100505.49747251217, 13093.869061309266, 13282.40229189708, 13576.932115339756, 13617.251051191883, 13758.65603359924, 14571.708565828836, 14652.340644670801, 15035.54893353201, 15048.322825472662, 15465.381384744935, 11979.880201198224, 13782.448702051806, 14187.361568729639, 14567.708645826811, 14642.85357146415, 7345.963270183829, 13990.300484975915, 14121.858781412055, 14153.0, 14576.927115364355, 13972.0, 14130.576082717535, 14193.716125677634, 14293.857061429253, 14391.28043597795, 10997.780044399227, 11340.979311861642, 11703.414829258674, 11785.175037747274, 11957.282563046245, 11576.503482537182, 11601.651950441501, 11789.941050294694, 11979.760404791681, 12013.939930300643], "value": 7779.992381874727, "unit": "score"}], "name": "dromaeo_css", "value": 7186.121260378911, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 113.0, 107.0, 112.0, 115.0, 113.0, 116.0, 113.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 108.0, 155.0, 193.0, 107.0, 130.0, 128.0, 107.0, 158.0, 106.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 185.0, 187.0, 183.0, 185.0, 184.0, 185.0, 182.0, 185.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 107.0, 94.0, 49.0, 73.0, 83.0, 113.0, 116.0, 58.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 129.0, 70.0, 74.0, 72.0, 115.0, 70.0, 68.0, 115.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 131.0, 116.0, 88.0, 89.0, 86.0, 90.0, 86.0, 91.0, 85.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 105.0, 94.0, 94.0, 95.0, 95.0, 94.0, 111.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 85.0, 84.0, 85.0, 86.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 56.0, 55.0, 54.0, 65.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 78.0, 77.0, 73.0, 70.0, 71.0, 70.0, 72.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 86.0, 88.0, 87.0, 86.0, 86.0, 90.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 148.0, 148.0, 149.0, 141.0, 137.0, 124.0, 230.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 162.0, 151.0, 233.0, 209.0, 168.0, 167.0, 168.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 65.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1492.6, "alertThreshold": 2.0}]} 11:17:01 INFO - Return code: 0 11:17:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:17:01 INFO - # TBPL SUCCESS # 11:17:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:17:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:17:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:17:01 INFO - 2016-08-22 11:17:01.986 screenresolution[1924:11191] starting screenresolution argv=screenresolution get 11:17:01 INFO - 2016-08-22 11:17:01.988 screenresolution[1924:11191] Display 0: 1600x1200x32@60 11:17:01 INFO - 2016-08-22 11:17:01.994 screenresolution[1925:11194] starting screenresolution argv=screenresolution list 11:17:01 INFO - Available Modes on Display 0 11:17:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:17:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:17:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:17:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:17:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:17:02 INFO - Intel Iris: 11:17:02 INFO - Chipset Model: Intel Iris 11:17:02 INFO - Type: GPU 11:17:02 INFO - Bus: Built-In 11:17:02 INFO - VRAM (Dynamic, Max): 1536 MB 11:17:02 INFO - Vendor: Intel (0x8086) 11:17:02 INFO - Device ID: 0x0a2e 11:17:02 INFO - Revision ID: 0x0009 11:17:02 INFO - Displays: 11:17:02 INFO - Display: 11:17:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:17:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:17:02 INFO - Display Serial Number: 1600x1200 60 11:17:02 INFO - Main Display: Yes 11:17:02 INFO - Mirror: Off 11:17:02 INFO - Online: Yes 11:17:02 INFO - Rotation: Supported 11:17:02 INFO - Return code: 0 11:17:02 INFO - Running post-action listener: _resource_record_post_action 11:17:02 INFO - [mozharness: 2016-08-22 18:17:02.233086Z] Finished run-tests step (success) 11:17:02 INFO - Running post-run listener: _resource_record_post_run 11:17:02 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 2084864; Write bytes: 709058560; Read time: 26; Write time: 2024 11:17:02 INFO - TinderboxPrint: CPU usage
53.4% 11:17:02 INFO - TinderboxPrint: I/O read bytes / time
2,084,864 / 26 11:17:02 INFO - TinderboxPrint: I/O write bytes / time
709,058,560 / 2,024 11:17:02 INFO - TinderboxPrint: CPU idle
2,259.2 (46.6%) 11:17:02 INFO - TinderboxPrint: CPU system
966.2 (19.9%) 11:17:02 INFO - TinderboxPrint: CPU user
1,624.3 (33.5%) 11:17:02 INFO - TinderboxPrint: Swap in / out
408,600,576 / 0 11:17:02 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389095936; Write bytes: 385492992; Read time: 29149; Write time: 751 11:17:02 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 2072576; Write bytes: 296931840; Read time: 24; Write time: 1211 11:17:02 INFO - Running post-run listener: _upload_blobber_files 11:17:02 INFO - Blob upload gear active. 11:17:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:02 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 11:17:02 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'] 11:17:02 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 11:17:03 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:04 INFO - (blobuploader) - INFO - Done attempting. 11:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:05 INFO - (blobuploader) - INFO - Done attempting. 11:17:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:17:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:07 INFO - (blobuploader) - INFO - Done attempting. 11:17:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:07 INFO - Return code: 0 11:17:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7394d135cdcb452083cbea4df49148cdf1c3fd0a994fe74eca5e23afd4fc2f54576d7df9bee4258709de4f912a3492d431082746b33d473487ed69941cbf1fd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1469d7fb6942a775700791441a9cfcfb72e7c8523fb0dbf012fa311f2a229cf4dc08455bf8f86ecac1527518659a99717b53aae814ef0874259eb04cc10fb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbfb2bf07435837698f7befc193537a155439ba7634b9a0dc2275995bb02730fd1a6af32f120ad6638601fd7ef637190f4a0473083d5deda1ada01b46df5153"} 11:17:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:07 INFO - Contents: 11:17:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7394d135cdcb452083cbea4df49148cdf1c3fd0a994fe74eca5e23afd4fc2f54576d7df9bee4258709de4f912a3492d431082746b33d473487ed69941cbf1fd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1469d7fb6942a775700791441a9cfcfb72e7c8523fb0dbf012fa311f2a229cf4dc08455bf8f86ecac1527518659a99717b53aae814ef0874259eb04cc10fb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbfb2bf07435837698f7befc193537a155439ba7634b9a0dc2275995bb02730fd1a6af32f120ad6638601fd7ef637190f4a0473083d5deda1ada01b46df5153"} 11:17:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:07 INFO - Copying logs to upload dir... 11:17:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.210573 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-22 11:17:08.066533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:08.069711) ========= 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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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/7394d135cdcb452083cbea4df49148cdf1c3fd0a994fe74eca5e23afd4fc2f54576d7df9bee4258709de4f912a3492d431082746b33d473487ed69941cbf1fd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1469d7fb6942a775700791441a9cfcfb72e7c8523fb0dbf012fa311f2a229cf4dc08455bf8f86ecac1527518659a99717b53aae814ef0874259eb04cc10fb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbfb2bf07435837698f7befc193537a155439ba7634b9a0dc2275995bb02730fd1a6af32f120ad6638601fd7ef637190f4a0473083d5deda1ada01b46df5153"} build_url:https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/TPaesbWwSSG_Bg9_00YWkQ/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/7394d135cdcb452083cbea4df49148cdf1c3fd0a994fe74eca5e23afd4fc2f54576d7df9bee4258709de4f912a3492d431082746b33d473487ed69941cbf1fd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e1469d7fb6942a775700791441a9cfcfb72e7c8523fb0dbf012fa311f2a229cf4dc08455bf8f86ecac1527518659a99717b53aae814ef0874259eb04cc10fb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbfb2bf07435837698f7befc193537a155439ba7634b9a0dc2275995bb02730fd1a6af32f120ad6638601fd7ef637190f4a0473083d5deda1ada01b46df5153"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:08.104598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:08.105128) ========= 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.E9rjnEHLaN/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.emoHYJHWLQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.005408 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:08.155422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 11:17:08.155857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 11:17:08.156411) ========= ========= Total master_lag: 0.19 =========