builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0242 starttime: 1472663402.61 results: success (0) buildid: 20160831072720 builduid: ddec93c760b04490aed8de77eff6046a revision: 51afefd5f63d13b28b304c52301818cfad7d229b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.608054) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.608609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.608931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.634445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.634818) ========= 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.3kZ8fknUh3/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.U32UhZUlFH/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-31 10:10:02-- 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% 122M=0s 2016-08-31 10:10:02 (122 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107486 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.765359) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.765703) ========= 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.3kZ8fknUh3/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.U32UhZUlFH/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.021676 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:02.815588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 10:10:02.816149) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 51afefd5f63d13b28b304c52301818cfad7d229b --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 51afefd5f63d13b28b304c52301818cfad7d229b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3kZ8fknUh3/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.U32UhZUlFH/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-31 10:10:02,902 truncating revision to first 12 chars 2016-08-31 10:10:02,902 Setting DEBUG logging. 2016-08-31 10:10:02,902 attempt 1/10 2016-08-31 10:10:02,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/51afefd5f63d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 10:10:04,310 unpacking tar archive at: fx-team-51afefd5f63d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.669171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 10:10:04.508335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:04.508719) ========= script_repo_revision: 51afefd5f63d13b28b304c52301818cfad7d229b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:04.509226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:04.509525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 10:10:04.528904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-31 10:10:04.529357) ========= /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.3kZ8fknUh3/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.U32UhZUlFH/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:04 INFO - MultiFileLogger online at 20160831 10:10:04 in /builds/slave/test 10:10:04 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:10:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:10:04 INFO - {'append_to_log': False, 10:10:04 INFO - 'base_work_dir': '/builds/slave/test', 10:10:04 INFO - 'blob_upload_branch': 'Fx-Team', 10:10:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:10:04 INFO - 'branch': 'Fx-Team', 10:10:04 INFO - 'buildbot_json_path': 'buildprops.json', 10:10:04 INFO - 'config_files': ('talos/mac_config.py',), 10:10:04 INFO - 'default_actions': ('clobber', 10:10:04 INFO - 'read-buildbot-config', 10:10:04 INFO - 'download-and-extract', 10:10:04 INFO - 'populate-webroot', 10:10:04 INFO - 'create-virtualenv', 10:10:04 INFO - 'install', 10:10:04 INFO - 'run-tests'), 10:10:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:10:04 INFO - 'download_minidump_stackwalk': True, 10:10:04 INFO - 'download_symbols': 'ondemand', 10:10:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:10:04 INFO - 'tooltool.py': '/tools/tooltool.py', 10:10:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:10:04 INFO - '/tools/misc-python/virtualenv.py')}, 10:10:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:10:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:10:04 INFO - 'installer_path': 'installer.exe', 10:10:04 INFO - 'log_level': 'info', 10:10:04 INFO - 'log_name': 'talos', 10:10:04 INFO - 'log_to_console': True, 10:10:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:10:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:10:04 INFO - 'opt_config_files': (), 10:10:04 INFO - 'pip_index': False, 10:10:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:10:04 INFO - 'cmd': ('bash', 10:10:04 INFO - '-c', 10:10:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:10:04 INFO - 'enabled': True, 10:10:04 INFO - 'halt_on_failure': False, 10:10:04 INFO - 'name': 'check_screen_resolution'},), 10:10:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:10:04 INFO - 'cmd': ('bash', 10:10:04 INFO - '-c', 10:10:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:10:04 INFO - 'enabled': True, 10:10:04 INFO - 'halt_on_failure': False, 10:10:04 INFO - 'name': 'check_screen_resolution'},), 10:10:04 INFO - 'run_cmd_checks_enabled': True, 10:10:04 INFO - 'sps_profile': False, 10:10:04 INFO - 'sps_profile_interval': 0, 10:10:04 INFO - 'suite': 'dromaeojs', 10:10:04 INFO - 'system_bits': '32', 10:10:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:10:04 INFO - 'title': 't-yosemite-r7-0242', 10:10:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:10:04 INFO - 'use_talos_json': True, 10:10:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:10:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:10:04 INFO - 'work_dir': 'build'} 10:10:04 INFO - [mozharness: 2016-08-31 17:10:04.724138Z] Running clobber step. 10:10:04 INFO - Running pre-action listener: _resource_record_pre_action 10:10:04 INFO - Running main action method: clobber 10:10:04 INFO - rmtree: /builds/slave/test/build 10:10:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:10:06 INFO - Running post-action listener: _resource_record_post_action 10:10:06 INFO - [mozharness: 2016-08-31 17:10:06.526281Z] Finished clobber step (success) 10:10:06 INFO - [mozharness: 2016-08-31 17:10:06.526537Z] Running read-buildbot-config step. 10:10:06 INFO - Running pre-action listener: _resource_record_pre_action 10:10:06 INFO - Running main action method: read_buildbot_config 10:10:06 INFO - Using buildbot properties: 10:10:06 INFO - { 10:10:06 INFO - "project": "", 10:10:06 INFO - "product": "firefox", 10:10:06 INFO - "script_repo_revision": "production", 10:10:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:10:06 INFO - "repository": "", 10:10:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:10:06 INFO - "buildid": "20160831072720", 10:10:06 INFO - "pgo_build": "False", 10:10:06 INFO - "basedir": "/builds/slave/test", 10:10:06 INFO - "buildnumber": 136, 10:10:06 INFO - "slavename": "t-yosemite-r7-0242", 10:10:06 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:10:06 INFO - "platform": "yosemite_r7", 10:10:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:10:06 INFO - "branch": "fx-team", 10:10:06 INFO - "repo_path": "integration/fx-team", 10:10:06 INFO - "revision": "51afefd5f63d13b28b304c52301818cfad7d229b", 10:10:06 INFO - "stage_platform": "macosx64", 10:10:06 INFO - "builduid": "ddec93c760b04490aed8de77eff6046a", 10:10:06 INFO - "slavebuilddir": "test" 10:10:06 INFO - } 10:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:10:06 INFO - Running post-action listener: _resource_record_post_action 10:10:06 INFO - [mozharness: 2016-08-31 17:10:06.532183Z] Finished read-buildbot-config step (success) 10:10:06 INFO - [mozharness: 2016-08-31 17:10:06.532413Z] Running download-and-extract step. 10:10:06 INFO - Running pre-action listener: _resource_record_pre_action 10:10:06 INFO - Running main action method: download_and_extract 10:10:06 INFO - mkdir: /builds/slave/test/build/tests 10:10: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:10:06 INFO - trying https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:08 INFO - Downloaded 1199 bytes. 10:10:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:10:08 INFO - Using the following test package requirements: 10:10:08 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:10:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:10:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:10:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'jsshell-mac.zip'], 10:10:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:10:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:10:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:10:08 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:10:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:10:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:10:08 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:10:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:08 INFO - trying https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:10:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:09 INFO - Downloaded 16396811 bytes. 10:10:09 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:10:16 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:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:16 INFO - trying https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:10:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:17 INFO - Downloaded 16396811 bytes. 10:10:17 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:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:23 INFO - trying https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:10:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:24 INFO - Downloaded 14413998 bytes. 10:10:24 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:10: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:10:24 INFO - trying https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:10:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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:10:27 INFO - Downloaded 111566460 bytes. 10:10:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:10:27 INFO - mkdir: /builds/slave/test/properties 10:10:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:10:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:10:27 INFO - Contents: 10:10:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:10:28 INFO - Running post-action listener: _resource_record_post_action 10:10:28 INFO - Running post-action listener: set_extra_try_arguments 10:10:28 INFO - [mozharness: 2016-08-31 17:10:28.430546Z] Finished download-and-extract step (success) 10:10:28 INFO - [mozharness: 2016-08-31 17:10:28.430703Z] Running populate-webroot step. 10:10:28 INFO - Running pre-action listener: _resource_record_pre_action 10:10:28 INFO - Running main action method: populate_webroot 10:10:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:10:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:10:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:10:28 INFO - '--tppagecycles', 10:10:28 INFO - '7'], 10:10:28 INFO - 'tests': ['tsvgm']}}, 10:10:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:10:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:10:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:10:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:10:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['damp', 'tps']}, 10:10:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'tests': ['damp', 'tps']}, 10:10:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['dromaeo_dom']}, 10:10:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:10:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['basic_compositor_video']}, 10:10:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:10:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['a11yr', 10:10:28 INFO - 'ts_paint', 10:10:28 INFO - 'tpaint', 10:10:28 INFO - 'sessionrestore', 10:10:28 INFO - 'sessionrestore_no_auto_restore', 10:10:28 INFO - 'tabpaint']}, 10:10:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:10:28 INFO - 'ts_paint', 10:10:28 INFO - 'tpaint', 10:10:28 INFO - 'sessionrestore', 10:10:28 INFO - 'sessionrestore_no_auto_restore', 10:10:28 INFO - 'tabpaint']}, 10:10:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:10:28 INFO - 'ts_paint', 10:10:28 INFO - 'tpaint', 10:10:28 INFO - 'sessionrestore', 10:10:28 INFO - 'sessionrestore_no_auto_restore', 10:10:28 INFO - 'tabpaint']}, 10:10:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:10:28 INFO - 'ts_paint', 10:10:28 INFO - 'tpaint', 10:10:28 INFO - 'sessionrestore', 10:10:28 INFO - 'sessionrestore_no_auto_restore', 10:10:28 INFO - 'tabpaint']}, 10:10:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['a11yr', 10:10:28 INFO - 'ts_paint', 10:10:28 INFO - 'tpaint', 10:10:28 INFO - 'sessionrestore', 10:10:28 INFO - 'sessionrestore_no_auto_restore', 10:10:28 INFO - 'tabpaint']}, 10:10:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['a11yr', 10:10:28 INFO - 'ts_paint', 10:10:28 INFO - 'tpaint', 10:10:28 INFO - 'sessionrestore', 10:10:28 INFO - 'sessionrestore_no_auto_restore', 10:10:28 INFO - 'tabpaint']}, 10:10:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['tsvgx', 10:10:28 INFO - 'tsvgr_opacity', 10:10:28 INFO - 'tart', 10:10:28 INFO - 'tscrollx', 10:10:28 INFO - 'cart']}, 10:10:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:10:28 INFO - 'tsvgr_opacity', 10:10:28 INFO - 'tart', 10:10:28 INFO - 'tscrollx', 10:10:28 INFO - 'cart']}, 10:10:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'talos_options': ['--disable-e10s'], 10:10:28 INFO - 'tests': ['tp5o']}, 10:10:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'tests': ['tp5o']}, 10:10:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'talos_options': ['--disable-e10s', 10:10:28 INFO - '--xperf_path', 10:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:28 INFO - 'tests': ['tp5n']}, 10:10:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:28 INFO - 'talos_options': ['--xperf_path', 10:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:28 INFO - 'tests': ['tp5n']}}, 10:10:28 INFO - 'talos.zip': {'path': '', 10:10:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:10:28 INFO - Running post-action listener: _resource_record_post_action 10:10:28 INFO - [mozharness: 2016-08-31 17:10:28.449463Z] Finished populate-webroot step (success) 10:10:28 INFO - [mozharness: 2016-08-31 17:10:28.449587Z] Running create-virtualenv step. 10:10:28 INFO - Running pre-action listener: _resource_record_pre_action 10:10:28 INFO - Running main action method: create_virtualenv 10:10:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:10:28 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:10:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:10:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:10:28 INFO - Using real prefix '/tools/python27' 10:10:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:10:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:32 INFO - Installing pip.................done. 10:10:32 INFO - Return code: 0 10:10:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:32 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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:32 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:10:32 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:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:32 INFO - 'HOME': '/Users/cltbld', 10:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:32 INFO - 'LOGNAME': 'cltbld', 10:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:32 INFO - 'MOZ_NO_REMOTE': '1', 10:10:32 INFO - 'NO_EM_RESTART': '1', 10:10:32 INFO - 'PAGER': '/bin/cat', 10:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:32 INFO - 'PWD': '/builds/slave/test', 10:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:32 INFO - 'SHELL': '/bin/bash', 10:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:32 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:32 INFO - 'USER': 'cltbld', 10:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:32 INFO - 'XPC_FLAGS': '0x0', 10:10:32 INFO - 'XPC_SERVICE_NAME': '0', 10:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:32 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:10:32 INFO - Cleaning up... 10:10:32 INFO - Return code: 0 10:10:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:32 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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:32 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:10:32 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:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:32 INFO - 'HOME': '/Users/cltbld', 10:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:32 INFO - 'LOGNAME': 'cltbld', 10:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:32 INFO - 'MOZ_NO_REMOTE': '1', 10:10:32 INFO - 'NO_EM_RESTART': '1', 10:10:32 INFO - 'PAGER': '/bin/cat', 10:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:32 INFO - 'PWD': '/builds/slave/test', 10:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:32 INFO - 'SHELL': '/bin/bash', 10:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:32 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:32 INFO - 'USER': 'cltbld', 10:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:32 INFO - 'XPC_FLAGS': '0x0', 10:10:32 INFO - 'XPC_SERVICE_NAME': '0', 10:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:32 INFO - Downloading/unpacking psutil>=3.1.1 10:10: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:10: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:10: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:10: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:10: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:10: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:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:35 INFO - Installing collected packages: psutil 10:10:35 INFO - Running setup.py install for psutil 10:10:35 INFO - building 'psutil._psutil_osx' extension 10:10:35 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:10:36 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:10:36 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:10:36 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:10:36 INFO - building 'psutil._psutil_posix' extension 10:10:36 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:10:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:10:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:10:36 INFO - ^ 10:10:36 INFO - 1 warning generated. 10:10:36 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:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:36 INFO - Successfully installed psutil 10:10:36 INFO - Cleaning up... 10:10:36 INFO - Return code: 0 10:10:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:10:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:36 INFO - 'HOME': '/Users/cltbld', 10:10:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:36 INFO - 'LOGNAME': 'cltbld', 10:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:36 INFO - 'MOZ_NO_REMOTE': '1', 10:10:36 INFO - 'NO_EM_RESTART': '1', 10:10:36 INFO - 'PAGER': '/bin/cat', 10:10:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:36 INFO - 'PWD': '/builds/slave/test', 10:10:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:36 INFO - 'SHELL': '/bin/bash', 10:10:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:36 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:36 INFO - 'USER': 'cltbld', 10:10:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:36 INFO - 'XPC_FLAGS': '0x0', 10:10:36 INFO - 'XPC_SERVICE_NAME': '0', 10:10:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10: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:10: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:10: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:10: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:10: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:10: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:10:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:10:39 INFO - Installing collected packages: mozsystemmonitor 10:10:39 INFO - Running setup.py install for mozsystemmonitor 10:10:39 INFO - Successfully installed mozsystemmonitor 10:10:39 INFO - Cleaning up... 10:10:39 INFO - Return code: 0 10:10:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:39 INFO - 'HOME': '/Users/cltbld', 10:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:39 INFO - 'LOGNAME': 'cltbld', 10:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:39 INFO - 'MOZ_NO_REMOTE': '1', 10:10:39 INFO - 'NO_EM_RESTART': '1', 10:10:39 INFO - 'PAGER': '/bin/cat', 10:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:39 INFO - 'PWD': '/builds/slave/test', 10:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:39 INFO - 'SHELL': '/bin/bash', 10:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:39 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:39 INFO - 'USER': 'cltbld', 10:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:39 INFO - 'XPC_FLAGS': '0x0', 10:10:39 INFO - 'XPC_SERVICE_NAME': '0', 10:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:40 INFO - Downloading/unpacking jsonschema==2.5.1 10:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:10:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:10:42 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:10:42 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:10:42 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:10:42 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:10:42 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:10:42 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:10:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:10:42 INFO - warning: no files found matching '*.txt' 10:10:42 INFO - no previously-included directories found matching 'build' 10:10:42 INFO - no previously-included directories found matching 'dist' 10:10:42 INFO - no previously-included directories found matching '.git*' 10:10:42 INFO - Installing collected packages: jsonschema, functools32 10:10:42 INFO - Running setup.py install for functools32 10:10:43 INFO - warning: no files found matching '*.txt' 10:10:43 INFO - no previously-included directories found matching 'build' 10:10:43 INFO - no previously-included directories found matching 'dist' 10:10:43 INFO - no previously-included directories found matching '.git*' 10:10:43 INFO - Successfully installed jsonschema functools32 10:10:43 INFO - Cleaning up... 10:10:43 INFO - Return code: 0 10:10:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:10: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:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:43 INFO - 'HOME': '/Users/cltbld', 10:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:43 INFO - 'LOGNAME': 'cltbld', 10:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:43 INFO - 'MOZ_NO_REMOTE': '1', 10:10:43 INFO - 'NO_EM_RESTART': '1', 10:10:43 INFO - 'PAGER': '/bin/cat', 10:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:43 INFO - 'PWD': '/builds/slave/test', 10:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:43 INFO - 'SHELL': '/bin/bash', 10:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:43 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:43 INFO - 'USER': 'cltbld', 10:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:43 INFO - 'XPC_FLAGS': '0x0', 10:10:43 INFO - 'XPC_SERVICE_NAME': '0', 10:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:10:43 INFO - Cleaning up... 10:10:43 INFO - Return code: 0 10:10:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10: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:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:43 INFO - 'HOME': '/Users/cltbld', 10:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:43 INFO - 'LOGNAME': 'cltbld', 10:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:43 INFO - 'MOZ_NO_REMOTE': '1', 10:10:43 INFO - 'NO_EM_RESTART': '1', 10:10:43 INFO - 'PAGER': '/bin/cat', 10:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:43 INFO - 'PWD': '/builds/slave/test', 10:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:43 INFO - 'SHELL': '/bin/bash', 10:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:43 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:43 INFO - 'USER': 'cltbld', 10:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:43 INFO - 'XPC_FLAGS': '0x0', 10:10:43 INFO - 'XPC_SERVICE_NAME': '0', 10:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:46 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:10:46 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:10:46 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:10:46 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:10:46 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:10:46 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:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:46 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:10:46 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:10:46 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:10:46 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:10:46 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:10:46 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:10:47 INFO - Downloading docopt-0.6.1.tar.gz 10:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:47 INFO - Running setup.py install for blobuploader 10:10:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:47 INFO - Running setup.py install for requests 10:10:48 INFO - Running setup.py install for docopt 10:10:48 INFO - Successfully installed blobuploader requests docopt 10:10:48 INFO - Cleaning up... 10:10:48 INFO - Return code: 0 10:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:48 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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:48 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:10:48 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:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:48 INFO - 'HOME': '/Users/cltbld', 10:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:48 INFO - 'LOGNAME': 'cltbld', 10:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:48 INFO - 'MOZ_NO_REMOTE': '1', 10:10:48 INFO - 'NO_EM_RESTART': '1', 10:10:48 INFO - 'PAGER': '/bin/cat', 10:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:48 INFO - 'PWD': '/builds/slave/test', 10:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:48 INFO - 'SHELL': '/bin/bash', 10:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:48 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:48 INFO - 'USER': 'cltbld', 10:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:48 INFO - 'XPC_FLAGS': '0x0', 10:10:48 INFO - 'XPC_SERVICE_NAME': '0', 10:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:48 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-BHUTh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-9pkBc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-cS19YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:48 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-9ZgSF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-i3wEIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-0G_3pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-5zBiyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-krZTwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-znfaGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-lcXPkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-9tpTB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-E7qJFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-lU4l84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:49 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Mm9Hdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:50 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Gr6y3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:50 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-fbPv7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:50 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-nkcKpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:50 INFO - Running setup.py install for manifestparser 10:10:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:50 INFO - Running setup.py install for mozcrash 10:10:50 INFO - Running setup.py install for mozdebug 10:10:50 INFO - Running setup.py install for mozdevice 10:10:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:50 INFO - Running setup.py install for mozfile 10:10:51 INFO - Running setup.py install for mozhttpd 10:10:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:51 INFO - Running setup.py install for mozinfo 10:10:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:51 INFO - Running setup.py install for mozInstall 10:10:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:51 INFO - Running setup.py install for mozleak 10:10:51 INFO - Running setup.py install for mozlog 10:10:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:51 INFO - Running setup.py install for moznetwork 10:10:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:52 INFO - Running setup.py install for mozprocess 10:10:52 INFO - Running setup.py install for mozprofile 10:10:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:52 INFO - Running setup.py install for mozrunner 10:10:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:52 INFO - Running setup.py install for mozscreenshot 10:10:52 INFO - Running setup.py install for moztest 10:10:52 INFO - Running setup.py install for mozversion 10:10:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:52 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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:52 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:10:52 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:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:52 INFO - 'HOME': '/Users/cltbld', 10:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:52 INFO - 'LOGNAME': 'cltbld', 10:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:52 INFO - 'MOZ_NO_REMOTE': '1', 10:10:52 INFO - 'NO_EM_RESTART': '1', 10:10:52 INFO - 'PAGER': '/bin/cat', 10:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:52 INFO - 'PWD': '/builds/slave/test', 10:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:52 INFO - 'SHELL': '/bin/bash', 10:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:52 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:52 INFO - 'USER': 'cltbld', 10:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:52 INFO - 'XPC_FLAGS': '0x0', 10:10:52 INFO - 'XPC_SERVICE_NAME': '0', 10:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-SBYKK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:53 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:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-n79oar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:53 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:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-jQC9Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:53 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:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-wKjPss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:53 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:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-zZAStr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:53 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:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-nkXvzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:53 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:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-FMdU0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-u6jYYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-tZ04NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-5fe0_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-2LoXIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-GqLv2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-utsuqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-gQK5CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-XlbEW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-AgK5x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:54 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:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-4VHGFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:55 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:10:55 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:10:55 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:10:55 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:10:55 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:10:55 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:10:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:57 INFO - Downloading blessings-1.6.tar.gz 10:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:57 INFO - Installing collected packages: blessings 10:10:57 INFO - Running setup.py install for blessings 10:10:57 INFO - Successfully installed blessings 10:10:57 INFO - Cleaning up... 10:10:57 INFO - Return code: 0 10:10:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:58 INFO - Reading from file tmpfile_stdout 10:10:58 INFO - Current package versions: 10:10:58 INFO - blessings == 1.6 10:10:58 INFO - blobuploader == 1.2.4 10:10:58 INFO - docopt == 0.6.1 10:10:58 INFO - functools32 == 3.2.3-2 10:10:58 INFO - jsonschema == 2.5.1 10:10:58 INFO - manifestparser == 1.1 10:10:58 INFO - mozInstall == 1.12 10:10:58 INFO - mozcrash == 0.17 10:10:58 INFO - mozdebug == 0.1 10:10:58 INFO - mozdevice == 0.48 10:10:58 INFO - mozfile == 1.2 10:10:58 INFO - mozhttpd == 0.7 10:10:58 INFO - mozinfo == 0.9 10:10:58 INFO - mozleak == 0.1 10:10:58 INFO - mozlog == 3.3 10:10:58 INFO - moznetwork == 0.27 10:10:58 INFO - mozprocess == 0.23 10:10:58 INFO - mozprofile == 0.28 10:10:58 INFO - mozrunner == 6.12 10:10:58 INFO - mozscreenshot == 0.1 10:10:58 INFO - mozsystemmonitor == 0.3 10:10:58 INFO - moztest == 0.7 10:10:58 INFO - mozversion == 1.4 10:10:58 INFO - psutil == 3.1.1 10:10:58 INFO - requests == 1.2.3 10:10:58 INFO - wsgiref == 0.1.2 10:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:58 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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:58 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:10:58 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:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:58 INFO - 'HOME': '/Users/cltbld', 10:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:58 INFO - 'LOGNAME': 'cltbld', 10:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:58 INFO - 'MOZ_NO_REMOTE': '1', 10:10:58 INFO - 'NO_EM_RESTART': '1', 10:10:58 INFO - 'PAGER': '/bin/cat', 10:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:58 INFO - 'PWD': '/builds/slave/test', 10:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:58 INFO - 'SHELL': '/bin/bash', 10:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:58 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:58 INFO - 'USER': 'cltbld', 10:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:58 INFO - 'XPC_FLAGS': '0x0', 10:10:58 INFO - 'XPC_SERVICE_NAME': '0', 10:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 INFO - Cleaning up... 10:10:58 INFO - Return code: 0 10:10:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10: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:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:58 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 0x10429ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104333618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952a4b5c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, '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.3kZ8fknUh3/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.U32UhZUlFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:10:58 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:10:58 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:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:58 INFO - 'HOME': '/Users/cltbld', 10:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:58 INFO - 'LOGNAME': 'cltbld', 10:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:58 INFO - 'MOZ_NO_REMOTE': '1', 10:10:58 INFO - 'NO_EM_RESTART': '1', 10:10:58 INFO - 'PAGER': '/bin/cat', 10:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:58 INFO - 'PWD': '/builds/slave/test', 10:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:58 INFO - 'SHELL': '/bin/bash', 10:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:10:58 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:58 INFO - 'USER': 'cltbld', 10:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:58 INFO - 'XPC_FLAGS': '0x0', 10:10:58 INFO - 'XPC_SERVICE_NAME': '0', 10:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:58 INFO - Cleaning up... 10:10:58 INFO - Return code: 0 10:10:58 INFO - Running post-action listener: _resource_record_post_action 10:10:58 INFO - Running post-action listener: _start_resource_monitoring 10:10:58 INFO - Starting resource monitoring. 10:10:58 INFO - [mozharness: 2016-08-31 17:10:58.781953Z] Finished create-virtualenv step (success) 10:10:58 INFO - [mozharness: 2016-08-31 17:10:58.783062Z] Running install step. 10:10:58 INFO - Running pre-action listener: _resource_record_pre_action 10:10:58 INFO - Running main action method: install 10:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:59 INFO - Reading from file tmpfile_stdout 10:10:59 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:59 INFO - Reading from file tmpfile_stdout 10:10:59 INFO - Output received: 10:10:59 INFO - Usage: mozinstall [options] installer 10:10:59 INFO - Options: 10:10:59 INFO - -h, --help show this help message and exit 10:10:59 INFO - -d DEST, --destination=DEST 10:10:59 INFO - Directory to install application into. [default: 10:10:59 INFO - "/builds/slave/test"] 10:10:59 INFO - --app=APP Application being installed. [default: firefox] 10:10:59 INFO - mkdir: /builds/slave/test/build/application 10:10:59 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:10:59 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:11:32 INFO - Reading from file tmpfile_stdout 10:11:32 INFO - Output received: 10:11:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:11:32 INFO - Running post-action listener: _resource_record_post_action 10:11:32 INFO - [mozharness: 2016-08-31 17:11:32.993320Z] Finished install step (success) 10:11:32 INFO - [mozharness: 2016-08-31 17:11:32.993516Z] Running run-tests step. 10:11:32 INFO - Running pre-action listener: _resource_record_pre_action 10:11:32 INFO - Running main action method: run_tests 10:11:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:33 INFO - 2016-08-31 10:11:33.008 screenresolution[2326:14919] starting screenresolution argv=screenresolution get 10:11:33 INFO - 2016-08-31 10:11:33.011 screenresolution[2326:14919] Display 0: 1600x1200x32@60 10:11:33 INFO - 2016-08-31 10:11:33.017 screenresolution[2327:14921] starting screenresolution argv=screenresolution list 10:11:33 INFO - Available Modes on Display 0 10:11:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:33 INFO - Intel Iris: 10:11:33 INFO - Chipset Model: Intel Iris 10:11:33 INFO - Type: GPU 10:11:33 INFO - Bus: Built-In 10:11:33 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:33 INFO - Vendor: Intel (0x8086) 10:11:33 INFO - Device ID: 0x0a2e 10:11:33 INFO - Revision ID: 0x0009 10:11:33 INFO - Displays: 10:11:33 INFO - Display: 10:11:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:33 INFO - Display Serial Number: 1600x1200 60 10:11:33 INFO - Main Display: Yes 10:11:33 INFO - Mirror: Off 10:11:33 INFO - Online: Yes 10:11:33 INFO - Rotation: Supported 10:11:33 INFO - Return code: 0 10:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:11:33 INFO - Python 2.7.3 10:11:33 INFO - Return code: 0 10:11:33 INFO - grabbing minidump binary from tooltool 10:11: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:11:33 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 0x104202d30>, '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 0x103f67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041fab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:11:33 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:11:33 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:11:33 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:11:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:11:33 INFO - Return code: 0 10:11:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:11:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:11:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:11:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:11:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:11:33 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/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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:11:33 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/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0242 --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:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3kZ8fknUh3/Render', 10:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:33 INFO - 'HOME': '/Users/cltbld', 10:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:33 INFO - 'LOGNAME': 'cltbld', 10:11:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:11:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:33 INFO - 'MOZ_NO_REMOTE': '1', 10:11:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:11:33 INFO - 'NO_EM_RESTART': '1', 10:11:33 INFO - 'PAGER': '/bin/cat', 10:11:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:33 INFO - 'PWD': '/builds/slave/test', 10:11:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:33 INFO - 'SHELL': '/bin/bash', 10:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U32UhZUlFH/Listeners', 10:11:33 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 10:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:33 INFO - 'USER': 'cltbld', 10:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:33 INFO - 'XPC_FLAGS': '0x0', 10:11:33 INFO - 'XPC_SERVICE_NAME': '0', 10:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:33 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/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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:11:33 INFO - mozversion application_buildid: 20160831072720 10:11:33 INFO - mozversion application_changeset: 51afefd5f63d13b28b304c52301818cfad7d229b 10:11:33 INFO - mozversion application_display_name: Nightly 10:11:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:11:33 INFO - mozversion application_name: Firefox 10:11:33 INFO - mozversion application_remotingname: firefox 10:11:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:11:33 INFO - mozversion application_vendor: Mozilla 10:11:33 INFO - mozversion application_version: 51.0a1 10:11:33 INFO - mozversion platform_buildid: 20160831072720 10:11:33 INFO - mozversion platform_changeset: 51afefd5f63d13b28b304c52301818cfad7d229b 10:11:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:11:33 INFO - mozversion platform_version: 51.0a1 10:11:33 INFO - using testdate: 1472663493 10:11:33 INFO - actual date: 1472663493 10:11:33 INFO - starting webserver on 'localhost:49530' 10:11:33 INFO - SUITE-START | Running 2 tests 10:11:33 INFO - TEST-START | dromaeo_css 10:11:33 INFO - operating with platform_type : mac_ 10:11:33 INFO - Initialising browser for dromaeo_css test... 10:11:33 INFO - TEST-INFO | started process 2337 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpYY8cMP/profile http://localhost:49530/getInfo.html) 10:11:36 INFO - PROCESS | 2337 | __metrics Screen width/height:1600/1200 10:11:36 INFO - PROCESS | 2337 | colorDepth:24 10:11:36 INFO - PROCESS | 2337 | Browser inner width/height: 1024/689 10:11:36 INFO - PROCESS | 2337 | __metrics 10:11:36 INFO - PROCESS | 2337 | 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:11:36 INFO - PROCESS | 2337 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:36 INFO - TEST-INFO | 2337: exit 0 10:11:36 INFO - Browser initialized. 10:11:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:11:36 INFO - TEST-INFO | started process 2339 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpYY8cMP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:49 INFO - PROCESS | 2339 | RSS: Main: 234512384 10:11:49 INFO - PROCESS | 2339 | 10:12:40 INFO - PROCESS | 2339 | 1472663560324 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:14:52 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49530/tests/dromaeo/cssquery-ext.html) 10:14:53 INFO - PROCESS | 2339 | RSS: Main: 372441088 10:14:53 INFO - PROCESS | 2339 | 10:17:56 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-ext.html (next: http://localhost:49530/tests/dromaeo/cssquery-jquery.html) 10:17:57 INFO - PROCESS | 2339 | RSS: Main: 371757056 10:17:57 INFO - PROCESS | 2339 | 10:20:59 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49530/tests/dromaeo/cssquery-mootools.html) 10:21:00 INFO - PROCESS | 2339 | RSS: Main: 363782144 10:21:00 INFO - PROCESS | 2339 | 10:24:02 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49530/tests/dromaeo/cssquery-prototype.html) 10:24:03 INFO - PROCESS | 2339 | RSS: Main: 353095680 10:24:03 INFO - PROCESS | 2339 | 10:27:06 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49530/tests/dromaeo/cssquery-yui.html) 10:27:07 INFO - PROCESS | 2339 | RSS: Main: 338038784 10:27:07 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-yui.html (next: http://localhost:49530/tests/dromaeo/cssquery-dojo.html) 10:30:10 INFO - PROCESS | 2339 | RSS: Main: 441544704 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | __start_tp_report 10:30:10 INFO - PROCESS | 2339 | _x_x_mozilla_page_load 10:30:10 INFO - PROCESS | 2339 | _x_x_mozilla_page_load_details 10:30:10 INFO - PROCESS | 2339 | |i|pagename|runs| 10:30:10 INFO - PROCESS | 2339 | |0;dojo.html;3261.7716759826812;3320.136764441245;3323.783954042987;3343.2143446290133;3393.949090763639;5523.226748255248;5601.467860553241;5641.943580564193;5722.227499287595;5749.482546570808;5642.294713160855;5668.801591944282;5694.77220911163;5696.629719068258;5713.17159011943;5120.513551212647;5163.845084647466;5171.974140129313;5174.275601415805;5239.083160446926;5226.608004399666;5237.371515418136;5239.895202095956;5255.290535777678;5287.524122828944;4326.286162783153;5198.584113270948;5216.400113986883;5235.057689615867;5246.737663116829;5262.842114736545;5292.417834038252;5294.338207724035;5303.124984377573;5352.437994010612;4151.418801367811;5111.795528178868;5150.407703114115;5203.713795741232;5211.817586384496;5586.24585680932;5640.153976903456;5700;5705.144228365778;5716.256886604757;6194.163787888622;6197.442230199304;6203.5037197024585;6212.347703491158;6236.781712640036;6087.4521293083835;6177.907331390033;6198.659073750942;6244.1570387997945;6254.21822272216;5796.768129274824;5804.854878628068;5860.09168578871;5871.383504731984;5889.234399528034;6271.592346497463;6285.779997700059;6292.150559674477;6302;6304.148939893055;6005.159277701126;6052.799744388505;6080.9391906081255;6151.477124444473;6159.907601385983;6155.753769849156;6241.469475094577;6243.063540468966;6254.468370188585;6257.311695713468;6142.57002009855;6190.597611155261;6199.442050215503;6200.596961197508;6209.285932117864;6086.543509236736;6091.8172454825535;6101.694915254219;6219.657918814509;6229.314775374705;4948.4061912570005;4953.504649535018;4975.353204083446;4979.45226025137;5006.173981293119;4465.59809617136;4474.217012022883;4492.9550704493195;4502.707324023993;4543.477500087466;5710.571707121982;5719.799807006818;5725.627834190847;5726.742296596663;5741.684207368551;6099.007149909933;6192.8761424771255;6198.2252218472695;6233.189685340877;6267.059941008794;5705.885882282331;5723.027085395493;5730.684812335361;5736.71316434185;5800.622959507618;5456.345238571317;5465.781368745285;5466.890662186734;5468.179773033997;5491.176323551499;5850.6782126981725;6143.082036033027;6258.687065646791;6298.748050077946;6314.652694101868;6268.216472940882;6283.308836027942;6283.7800676976085;6286.622802631857;6287.182666253358;5417.268668729828;6245.376202187555;6292.842678933063;6305.464035556845;6324.083007963912;6021.729022194099;6099.915141108964;6138.877222455615;6161.784337548164;6213.782517611862;6158.414950579688;6225.688715564113;6231.22109736283;6258.499320054476;6266.874662506633;6114.816555503342;6131.60144590618;6144.907826382519;6148.907766383597;6150.04674275488;6007.12896629995;6098.664573448503;6104.847378815565;6144.1398204250545;6195.256569211543;5961.344252132175;6007.038873780349;6010.9699451502465;6043.45608895184;6054.091886217103;6109.541784366279;6131.172291740558;6138.693065346625;6142.508599311955;6189.133521307111;5812.622179558315;5858.209141765978;5921.585489015728;5986.850328741816;5992.490638295793 10:30:10 INFO - PROCESS | 2339 | |1;ext.html;453.44453045019856;488.79226328810256;500.65955150497695;528.7964133808482;548.3611592494743;30983.690163098363;39932.80033599835;41069;41149.58850411495;41204;42361;42748.358774618326;42839.357409638804;42859.57140428595;42928;8753.912460875405;9617.807643847136;9830.26273029522;9860.408375497458;9863.112319891208;8815.382923195379;8952.239059679934;8962.058983806672;9002.729918102468;11798.292102473835;11942.104342174329;12273.509059637603;12352.567660131897;12357.011439084896;12371.628851134481;12262.50949962005;12339.568115116017;12353.62939111828;12354.320512371816;12385.318807465675;12065.215760975509;12099.274043557414;12102.334371609559;12105.45525451348;12148.635540933787;40391.39412908809;40697.38953915694;40726.592734072874;40739.98150046243;40808.77573672795;3352;3464.22055037617;3531.04661741331;3583.62371950944;4076.5719599441927;30074.69925300741;31007;31301.37397252065;31372.686273137206;31853.681463185305;3272.8199949003033;3278.7704860659765;3339.666033396665;3354.127926739041;3381.340638575479;498286;503616.4819175917;505517;509124;518325;57167.42832571621;57333;57465.13802292969;57481.425185747605;57581.13628295579;34027;34743;34746.30507389838;35951.28097438037;36039.81980090083;16285.511434656979;16455.83544164567;16462.917685411496;16485.752713709306;16501.752473712902;12557.874421255854;12673.04952128594;12683.556075537312;12695.047871409497;12695.746085078246;15969.680606387807;16276.26756795947;17033.659326813642;17522.649547008987;18428.631427371376;6112.965442807815;7520.924790752022;7685.884711729329;7712.0412849749955;7774.572398518023;757.6704133701858;874.8337815815102;907.1291560102376;928.9262267830422;1134.387430787382;29417.411651766844;29921.251968700522;29960;30534.694653053186;30554.38891222163;1034.3121823987115;1066.5094056733835;1108.4236197177422;1120.7422292872523;1122.1023181454802;14884.851151488563;15483.303251353716;15545.222738863238;15651;15882.76175857363;684926;690603;694163;694633;697188;48762.780930476314;49614;49954.75022624864;51899.22151167736;58908.11637825436;1358.5109360630165;1368.4594585138814;1368.7134093951654;1388.902776805614;1391.1027387335112;30457;30953.535696964114;31129.8443507781;31368.68631313749;31628;48370.274445884046;48669.02661946812;48797;48863.511364887316;48900.75549622229;593813;594577;595808;597872;662428;39772.80113599414;40157.795266142064;40564.594354056084;40829.79585102056;41133.58866411298;44965;45227.32159017552;45556;45745.54254457413;45946.85132871571;35036;37366.252674945805;37845.62154378421;38676.41985370166;38957.80521097376;37314.88055358343;37587.62412375951;38027.80986095052;38500;38959.6104038956;36023.63976360203;36931.81534092312;36993;37187.442188367735;37579.436308454846;32165.874194403084;33215.501767473994;33230;33401.49897751487;33488.49767253542;24830.37924051841;25239.62140567856;25712;25950.48099037971;26521.867390662923 10:30:10 INFO - PROCESS | 2339 | |2;jquery.html;355.22915273855733;372.64598631300265;374.07043496910154;386.6018001458498;404.31266846361194;15541.689166216684;15705.309252325695;20479.385618431435;20757.792422075774;20888.373348799523;20897;21132.577348453022;21494.098296729935;21777.020034098463;21810.89094554525;5879.853003674921;5931.466168044875;6043.818685439422;6152.292486364058;6186.84532886677;4181.289180839264;6011.158437818709;6097.176881121059;6111.327753947062;6478.3845534674365;6776.390124888759;6788.592684438925;6797.52417330787;6816.420604248645;6883.174019117688;6583.703733331988;6666.567106226006;6710.5302628816;6760.797176084725;6802.319768023208;5654.6041777075625;5869.207656966298;5879.588428809985;5891.646501209898;5901;19601.9019904901;26664.93340266387;26865.597016044776;27068.59397109045;27073.32316692079;2415.9154429595055;2606.5568853294985;2954.2762023304213;3067.9846600767078;3203.759718021158;15486.845131548653;15673.373065077383;15963.680726385523;15970.840291597167;16104.83895161045;1878.6994080946984;1912.8660993730305;1919.221276952112;1928.643201007818;1980.3464856597288;111929.68773434915;117070;117094;117879;123940;10725;10895.509702063426;11016.669499915015;11184.888151118548;11297.49161287744;11357.716057098638;13841.653958651113;13861.930690346484;13867.514636987657;13870.959678024188;8570.4000719949;8703.173198546128;8722.520261385685;8729.563521823884;8881.866771998426;6675.833104172434;8124.512529248264;8808.295336373074;8838.911610883808;9032.63869445228;6038.973374526341;6084.5436592255755;6349.936500634934;6705.228898676617;6712.328767123248;1673.6820004199162;1760.1991094052175;1850.1581780289937;1875.7655293088364;1897.297999740105;899.6311512279934;921.8386782313069;986.4032260482448;1010.8281592129356;1101.1851230089835;21731.891340543196;22078.558428831653;22267.55464890693;22276.443088922908;22329.888350558143;933.7618907178762;978.280963491833;982.2633025231077;985.8176237396104;1017.5726194998118;11343.43282835855;11569.132315076404;11859.58491452795;11926.46330915111;11931.343776092224;564599;569406;578086;583731;586077;84790;114412.28381574283;119173;119700;136050;784.584170389683;970.4371464550403;1000.049952545085;1000.8148492528906;1002.734275417015;17486;18390.89654620727;18629.975351355806;19204.135813888686;19229.94235317071;36742.0175752518;51903.480965191375;53041.7347913258;53691.194632079765;53821;54367;77001.14994250154;77919;78128.26551070686;79658.60170699109;6292.905606415999;7898.2891539761695;7993;8048.034235891496;8112.391570632109;11151.72120696989;11812.527498900292;12413.93793031029;12800.10399272042;12950.481980720666;8923.884514435695;11182.384968826467;11239.55041798319;11329.71675708114;11403.486843092247;10582.153427725609;10714.785704285714;11058.391788451712;11171.38557379352;11339.886601133883;11030.393328367018;11182.161337899854;11183.944080279873;11411.25826821254;11482.77034459323;5920.644761314335;7826.41301902371;7914.24814642608;8298.63488905659;8373.288270497076;9574.664886728931;10992.780144396907;11071.83392249133;11303.71740706456;11328.9433552835 10:30:10 INFO - PROCESS | 2339 | |3;mootools.html;1322.6032190342894;1476.1512130524948;1487.9479218227361;1702.4892532240324;1918.6834172361562;7921.84156316874;8653.09142540033;9139.908600913997;9145.817083658323;9252.444853308789;8972.416792908456;9100.362974591764;9103.908960910405;9111.908880911189;9118.544072796367;2389.9880500597515;2427.5630386530506;2428.138011006094;2430.2466235467064;2430.6111022236446;2349.694539709835;2400.8919598618104;2402.3633737059695;2403.5072810073893;2407.1334319644916;2383.249276477904;2399.124319623342;2415.758424157579;2415.891284892184;2417.721961974369;1949.7465329507145;2347.260612906929;2382.3686723018327;2387.4747555537756;2397.2568503763714;2347.2136834160406;2372.50177462733;2375.1568193291478;2375.394274460019;2382.54731600997;8670.52312122833;9046.231070359026;9121.270298376114;9127.863082053775;9128.726138215865;5240.554552863011;5445.455454454523;5462.590305727047;5478.986387518322;5480.862978425532;3644.2893635741043;3686.5760437549757;3690.0221441317804;3752.774833509998;3763.4354846773203;1081.5835903177256;1098.1873413673904;1099.6316234061599;1106.623747925701;1114.2311804854623;11796.882031179664;11815.940920295343;11874.465649045813;11899.524019039314;11900.285982841056;4362.541933097043;4487.753173575485;4614.930776038362;4658.394408726844;4691.296305554194;9144.3598948073;9145.725628231165;9156.908430915739;9163.266938644892;9177.724668259963;5255.973720131375;5256.6057545684225;5258.2638430619745;5265.447128051576;5265.842024739264;4447.3329000650165;4612.76936153191;4796.424429068465;4940.604751619861;4943.9258411123865;3718.2935242303874;3732.4401339799247;3825.464434979105;3851.826667799956;3870.7871067091583;1175.1010476985114;1185.5020891225706;1187.0503597122267;1196.4376742930983;1203.3562044306254;905.1265528764774;917.8623206518942;918.1094338491653;944.7326416600215;981.3621146254849;5663.377028526858;5967.254093238345;5988.305262631746;6163.075538669235;6170.136180934673;439.9538048504861;448.7195502810743;461.11926220918554;461.3448902558375;462.00438055988724;3941.802909854553;3998.7800670962793;4022.9741415938747;4058.066644671683;4081.673466122703;10310.484475776331;10680.359178449318;10761.677149685522;10973.177011724152;10983.39591322469;10774.760902496313;10836.566537338418;10900.182486313559;10905.890941090645;10906.945465272782;6903.6548172591165;8341.04078031022;8356.164383561716;8361;8364.958175209207;5895.94104058954;5982.670953097621;6066.15073889647;6119.632822030692;6121.265448146251;9629.759256018655;10175.440350780778;10185.694429167137;10249.386406466303;10258.333208341433;10181.898181018096;10331.380117192992;10331.741706457398;10357.689269321932;10365.378077315385;6860.2453730088655;6965.616891071039;7478.4765066444825;7479.626018699152;7644.15914249421;8288.088310285984;8515.318774497902;8526.147385261673;8541.273991710774;8544.060153383247;7513.211112833293;7665.271799179069;7682.7311044113185;7725.343345815669;7782.338501227459;7379.446541509301;7467.066616672916;7481.887771683538;7497.737579184921;7514.098308203051;7002.509824312249;7126.322999315057;7128.073350464407;7131.500794944512;7151.678174482265;4906.313116163668;5063.113955057924;5073.746312684425;5106.514881086291;5147.536721695065;4941.802327906844;4974.801007959786;5112.897742045213;5143.382794064736;5243.528082472443 10:30:10 INFO - PROCESS | 2339 | |4;prototype.html;299.3384619989822;302.3952095808383;310.36530295545634;311.15521359508926;315.11924171939427;4213.578642135785;5370.2750128732605;5397.649152805065;5403.8108666196595;5451.291332126828;4938.6542941993985;4958.702477851331;4964.925526117102;5217.269652198677;5277.419483856773;3553.1294832766007;3977.3636218205093;4026.074002979309;4039.1719697462095;4058.959410405888;3690.6493883081066;3907.2771537265553;4051.4604450308843;4090.2433049885717;4104.8358065677485;3300.290437555925;3769.1907884215593;3995.841206050242;4005.2590270799997;4016.959830401702;3732.346839303125;4044.676425885922;4067.6542493888055;4080.6327430531096;4090.6318431341024;2940.7354837419903;3252.9186770330693;3412.8805491807916;3538.8938331850086;3561.5013898054294;4059.4925634295714;4306.80619372129;5155.639105262633;5181.119209734355;5202.401723801773;4318.395424640553;4524.11779702958;4607.723536587782;4612.515685852971;4639.512851150615;4376.102898905717;5506.724663766796;5509.669419834822;5513.959834861087;5540.667559946376;3859.3019071608683;3870.9225815483533;3890.455336252927;3898.6881049516255;3919.647231749156;4406.383106365111;5153.016088805799;5476.808311709111;5835.212246346731;5848.093545500455;3415.6849612899214;3856.4547398716713;3932.2332145231403;3939.6060393960374;3968.583298753647;3972.205558888234;4023.517177938666;4034.8184331705143;4053.412255223035;4070.7354021988476;4192.748435093904;4521.909561808746;4590.8163673453355;4702.36518070063;4706.576408123286;5299.4435584263865;5459.69971651563;5599.852030333772;5640.266765320482;5652.689102099424;1165.6444784340858;1210.7396909664465;1317.6047185844209;1335.599320203935;1336.1982810313734;662.0995446193174;833.5496236548362;856.9742907712779;877.3244601656817;911.2026976395654;4616.699914505613;4812.735299558558;4881.4630390657;5225.608079394061;5251.159814429673;4981.103401387712;5208.817691380784;5544.7227638618715;5676.148577713376;5732.34078081026;4362.738235705868;4876.902461950812;5165.985265746362;5168.431472538018;5222.556082732935;2559.3473664215876;2777.3195567086195;3017.9547306790414;3018.7170452557575;3020.2147441665325;4648.395708557933;4850.854474365775;4909.558139767438;5180.559652429511;5705.657660540381;5539.972300138474;5839;5914.9112763308585;5947.37552556984;5951.7619295227705;4853.369062021985;5302.337207849019;5901.76392944286;5964.373740757158;5983.790567330123;5143.537081662668;5391.757370918396;5525.806596769094;5685.459881311269;5820.941790582209;5642;5728.968785618628;5787.421257874347;5791.391903850035;5818.359980402068;4963.602911766978;5111.795528178831;5186.662866913639;5477.835664930059;6020.397960203944;3730.2353017630776;3848.2303539291693;3863.497745293094;3881.902952426212;3908.8045597719433;5058.9494105058475;5310.362756469249;5513.5037846594;5734.569907256889;5745.138229265476;5618.129189975561;5647.15292706081;5719.8856022880145;5739.9139012914;5789.421057894177;4807.663463557657;5011.298418221525;5551.278333816578;5613.073842815889;5703.543716502752;4363.694541382073;5040.463582775531;5271.525562699376;5517.751701173537;5603.467670571289;4602.654800890014;4640.303954406866;4750;4853.611711063036;5361.410244873139;5018.723970181675;5340.839774806762;5487;5522.591739106502;5567.721613919207 10:30:10 INFO - PROCESS | 2339 | |5;yui.html;712.3019440947871;735.7682330066028;748.2181120728841;785.2304741353473;792.7066985215471;15291.617709557268;15964.600884977852;16003.679926401494;16013.599660008505;16066.116363599982;11972.521099156045;14295;14378.928105359459;14400.567982960501;14850.405983760664;681.2200030964542;701.6877489517167;832.6378025558886;837.4723923927917;869.1786261982429;820.2535692519808;831.9001719793603;832.3507664022043;832.9958350208241;841.1756478650926;922.7185708358948;923.5751554285036;924.5469719837265;926.2775035472342;926.6154545863492;722.4762047515509;742.0946445336681;743.8363560016787;916.4913473022469;916.9541522923861;561.9241402410663;672.092674888901;689.3657834792003;696.1298377028714;703.4231929817552;14854.851451485454;14859.925700371537;14889.329980150918;14891.404343826234;14896.478623248135;11516.021138203263;13766;14033.228172450512;14227.78658320126;14366.20985845778;12754.170978886435;12800.103992720513;12895.742085158337;13277.336133193301;13625.318734063356;4537.954620453786;4550.840720574764;4560.452745670541;4724.456687480915;4750.976245118787;110666;111775.3233701487;112756.43621781921;114647;117330.41334793271;10942.124630029579;10948;10958.671239862817;11030.558777648965;11468.827967580493;21782;21824.345269641937;21883.562328753334;21909.12363505442;22225.222117225818;7202.315780000891;7800.609969501502;7801;7840.215978402114;7853.528788272722;4385.035292235703;4411.073674528385;4427.69006169565;4471.463424389029;4564.748938808398;3469.8785542505893;3537.4870643756512;3571;3576.91057723559;3579.8926032219074;669.8961660942562;670.3564578005072;671.4661843834164;678.9117414736053;723.7539236659561;564.7599770097775;592.9051351783694;616.0605077257129;658.578509753758;690.9619970901548;8882.86675699865;9290.581923813445;9514.666986655433;9536.904630953602;9584.760380990392;560.8317504748641;645.2225068792094;656.8981807819796;677.4749569083999;681.7852376501386;4334.804933777988;4605.608523275492;4631.050078690096;4639.559241872017;4714.882127946828;88905;112909;138981.61018389688;144465.27767361305;149902;127588;127836.72163278435;128804;129586;136239;85124.57437712772;104035.4798226004;104243.95756042494;108261;108326.90940016256;8791.648334066565;8846.456340159477;8857.3799834011;8965.197862773482;9074.364794464323;59896;61115;61175.188357106;63728.04407933977;65140.371490711215;96571.55142673006;97119.028809711;98899.01100989185;100581;102454.48772756387;11779.587714429954;11812.586559470377;11865.525378985089;11941.880581194077;11943.880561194625;13169.670758231121;13192.67018324511;13193.80209296842;13539.79006923241;13626;9147.359684821999;9202.089705654944;12188.51245950152;12432.378381080729;12718.618441446772;13132.606021819362;13455.245046510183;13789.793153102511;13848.723025539633;14118.21153327131;13044.413001414769;13229.867701323248;13418.530351437652;13653.590392288248;13750;10801.567937282422;10835.729106772395;10970.780584388109;11187.272827266203;11308.547658093585;10950.397728124712;11257.10865010489;11349.48927298257;11493;11523.250988685708 10:30:10 INFO - PROCESS | 2339 | __end_tp_report 10:30:10 INFO - PROCESS | 2339 | __start_cc_report 10:30:10 INFO - PROCESS | 2339 | _x_x_mozilla_cycle_collect,1158 10:30:10 INFO - PROCESS | 2339 | __end_cc_report 10:30:10 INFO - PROCESS | 2339 | __startTimestamp1472664610723__endTimestamp 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | ------- Summary: start ------- 10:30:10 INFO - PROCESS | 2339 | Number of tests: 6 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | [#0] dojo.html Cycles:165 Average:5730.40 Median:5992.49 stddev:644.60 (10.8%) stddev-sans-first:616.81 10:30:10 INFO - PROCESS | 2339 | Values: 3261.8 3320.1 3323.8 3343.2 3393.9 5523.2 5601.5 5641.9 5722.2 5749.5 5642.3 5668.8 5694.8 5696.6 5713.2 5120.5 5163.8 5172.0 5174.3 5239.1 5226.6 5237.4 5239.9 5255.3 5287.5 4326.3 5198.6 5216.4 5235.1 5246.7 5262.8 5292.4 5294.3 5303.1 5352.4 4151.4 5111.8 5150.4 5203.7 5211.8 5586.2 5640.2 5700.0 5705.1 5716.3 6194.2 6197.4 6203.5 6212.3 6236.8 6087.5 6177.9 6198.7 6244.2 6254.2 5796.8 5804.9 5860.1 5871.4 5889.2 6271.6 6285.8 6292.2 6302.0 6304.1 6005.2 6052.8 6080.9 6151.5 6159.9 6155.8 6241.5 6243.1 6254.5 6257.3 6142.6 6190.6 6199.4 6200.6 6209.3 6086.5 6091.8 6101.7 6219.7 6229.3 4948.4 4953.5 4975.4 4979.5 5006.2 4465.6 4474.2 4493.0 4502.7 4543.5 5710.6 5719.8 5725.6 5726.7 5741.7 6099.0 6192.9 6198.2 6233.2 6267.1 5705.9 5723.0 5730.7 5736.7 5800.6 5456.3 5465.8 5466.9 5468.2 5491.2 5850.7 6143.1 6258.7 6298.7 6314.7 6268.2 6283.3 6283.8 6286.6 6287.2 5417.3 6245.4 6292.8 6305.5 6324.1 6021.7 6099.9 6138.9 6161.8 6213.8 6158.4 6225.7 6231.2 6258.5 6266.9 6114.8 6131.6 6144.9 6148.9 6150.0 6007.1 6098.7 6104.8 6144.1 6195.3 5961.3 6007.0 6011.0 6043.5 6054.1 6109.5 6131.2 6138.7 6142.5 6189.1 5812.6 5858.2 5921.6 5986.9 5992.5 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | [#1] ext.html Cycles:180 Average:72465.59 Median:37090.22 stddev:162695.57 (438.6%) stddev-sans-first:163062.14 10:30:10 INFO - PROCESS | 2339 | Values: 453.4 488.8 500.7 528.8 548.4 30983.7 39932.8 41069.0 41149.6 41204.0 42361.0 42748.4 42839.4 42859.6 42928.0 8753.9 9617.8 9830.3 9860.4 9863.1 8815.4 8952.2 8962.1 9002.7 11798.3 11942.1 12273.5 12352.6 12357.0 12371.6 12262.5 12339.6 12353.6 12354.3 12385.3 12065.2 12099.3 12102.3 12105.5 12148.6 40391.4 40697.4 40726.6 40740.0 40808.8 3352.0 3464.2 3531.0 3583.6 4076.6 30074.7 31007.0 31301.4 31372.7 31853.7 3272.8 3278.8 3339.7 3354.1 3381.3 498286.0 503616.5 505517.0 509124.0 518325.0 57167.4 57333.0 57465.1 57481.4 57581.1 34027.0 34743.0 34746.3 35951.3 36039.8 16285.5 16455.8 16462.9 16485.8 16501.8 12557.9 12673.0 12683.6 12695.0 12695.7 15969.7 16276.3 17033.7 17522.6 18428.6 6113.0 7520.9 7685.9 7712.0 7774.6 757.7 874.8 907.1 928.9 1134.4 29417.4 29921.3 29960.0 30534.7 30554.4 1034.3 1066.5 1108.4 1120.7 1122.1 14884.9 15483.3 15545.2 15651.0 15882.8 684926.0 690603.0 694163.0 694633.0 697188.0 48762.8 49614.0 49954.8 51899.2 58908.1 1358.5 1368.5 1368.7 1388.9 1391.1 30457.0 30953.5 31129.8 31368.7 31628.0 48370.3 48669.0 48797.0 48863.5 48900.8 593813.0 594577.0 595808.0 597872.0 662428.0 39772.8 40157.8 40564.6 40829.8 41133.6 44965.0 45227.3 45556.0 45745.5 45946.9 35036.0 37366.3 37845.6 38676.4 38957.8 37314.9 37587.6 38027.8 38500.0 38959.6 36023.6 36931.8 36993.0 37187.4 37579.4 32165.9 33215.5 33230.0 33401.5 33488.5 24830.4 25239.6 25712.0 25950.5 26521.9 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | [#2] jquery.html Cycles:180 Average:34060.48 Median:14635.75 stddev:96006.68 (656.0%) stddev-sans-first:96242.65 10:30:10 INFO - PROCESS | 2339 | Values: 355.2 372.6 374.1 386.6 404.3 15541.7 15705.3 20479.4 20757.8 20888.4 20897.0 21132.6 21494.1 21777.0 21810.9 5879.9 5931.5 6043.8 6152.3 6186.8 4181.3 6011.2 6097.2 6111.3 6478.4 6776.4 6788.6 6797.5 6816.4 6883.2 6583.7 6666.6 6710.5 6760.8 6802.3 5654.6 5869.2 5879.6 5891.6 5901.0 19601.9 26664.9 26865.6 27068.6 27073.3 2415.9 2606.6 2954.3 3068.0 3203.8 15486.8 15673.4 15963.7 15970.8 16104.8 1878.7 1912.9 1919.2 1928.6 1980.3 111929.7 117070.0 117094.0 117879.0 123940.0 10725.0 10895.5 11016.7 11184.9 11297.5 11357.7 13841.7 13861.9 13867.5 13871.0 8570.4 8703.2 8722.5 8729.6 8881.9 6675.8 8124.5 8808.3 8838.9 9032.6 6039.0 6084.5 6349.9 6705.2 6712.3 1673.7 1760.2 1850.2 1875.8 1897.3 899.6 921.8 986.4 1010.8 1101.2 21731.9 22078.6 22267.6 22276.4 22329.9 933.8 978.3 982.3 985.8 1017.6 11343.4 11569.1 11859.6 11926.5 11931.3 564599.0 569406.0 578086.0 583731.0 586077.0 84790.0 114412.3 119173.0 119700.0 136050.0 784.6 970.4 1000.0 1000.8 1002.7 17486.0 18390.9 18630.0 19204.1 19229.9 36742.0 51903.5 53041.7 53691.2 53821.0 54367.0 77001.1 77919.0 78128.3 79658.6 6292.9 7898.3 7993.0 8048.0 8112.4 11151.7 11812.5 12413.9 12800.1 12950.5 8923.9 11182.4 11239.6 11329.7 11403.5 10582.2 10714.8 11058.4 11171.4 11339.9 11030.4 11182.2 11183.9 11411.3 11482.8 5920.6 7826.4 7914.2 8298.6 8373.3 9574.7 10992.8 11071.8 11303.7 11328.9 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | [#3] mootools.html Cycles:180 Average:5746.56 Median:4743.86 stddev:3251.32 (68.5%) stddev-sans-first:3243.44 10:30:10 INFO - PROCESS | 2339 | Values: 1322.6 1476.2 1487.9 1702.5 1918.7 7921.8 8653.1 9139.9 9145.8 9252.4 8972.4 9100.4 9103.9 9111.9 9118.5 2390.0 2427.6 2428.1 2430.2 2430.6 2349.7 2400.9 2402.4 2403.5 2407.1 2383.2 2399.1 2415.8 2415.9 2417.7 1949.7 2347.3 2382.4 2387.5 2397.3 2347.2 2372.5 2375.2 2375.4 2382.5 8670.5 9046.2 9121.3 9127.9 9128.7 5240.6 5445.5 5462.6 5479.0 5480.9 3644.3 3686.6 3690.0 3752.8 3763.4 1081.6 1098.2 1099.6 1106.6 1114.2 11796.9 11815.9 11874.5 11899.5 11900.3 4362.5 4487.8 4614.9 4658.4 4691.3 9144.4 9145.7 9156.9 9163.3 9177.7 5256.0 5256.6 5258.3 5265.4 5265.8 4447.3 4612.8 4796.4 4940.6 4943.9 3718.3 3732.4 3825.5 3851.8 3870.8 1175.1 1185.5 1187.1 1196.4 1203.4 905.1 917.9 918.1 944.7 981.4 5663.4 5967.3 5988.3 6163.1 6170.1 440.0 448.7 461.1 461.3 462.0 3941.8 3998.8 4023.0 4058.1 4081.7 10310.5 10680.4 10761.7 10973.2 10983.4 10774.8 10836.6 10900.2 10905.9 10906.9 6903.7 8341.0 8356.2 8361.0 8365.0 5895.9 5982.7 6066.2 6119.6 6121.3 9629.8 10175.4 10185.7 10249.4 10258.3 10181.9 10331.4 10331.7 10357.7 10365.4 6860.2 6965.6 7478.5 7479.6 7644.2 8288.1 8515.3 8526.1 8541.3 8544.1 7513.2 7665.3 7682.7 7725.3 7782.3 7379.4 7467.1 7481.9 7497.7 7514.1 7002.5 7126.3 7128.1 7131.5 7151.7 4906.3 5063.1 5073.7 5106.5 5147.5 4941.8 4974.8 5112.9 5143.4 5243.5 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | [#4] prototype.html Cycles:180 Average:4460.25 Median:4948.68 stddev:1362.60 (27.5%) stddev-sans-first:1330.15 10:30:10 INFO - PROCESS | 2339 | Values: 299.3 302.4 310.4 311.2 315.1 4213.6 5370.3 5397.6 5403.8 5451.3 4938.7 4958.7 4964.9 5217.3 5277.4 3553.1 3977.4 4026.1 4039.2 4059.0 3690.6 3907.3 4051.5 4090.2 4104.8 3300.3 3769.2 3995.8 4005.3 4017.0 3732.3 4044.7 4067.7 4080.6 4090.6 2940.7 3252.9 3412.9 3538.9 3561.5 4059.5 4306.8 5155.6 5181.1 5202.4 4318.4 4524.1 4607.7 4612.5 4639.5 4376.1 5506.7 5509.7 5514.0 5540.7 3859.3 3870.9 3890.5 3898.7 3919.6 4406.4 5153.0 5476.8 5835.2 5848.1 3415.7 3856.5 3932.2 3939.6 3968.6 3972.2 4023.5 4034.8 4053.4 4070.7 4192.7 4521.9 4590.8 4702.4 4706.6 5299.4 5459.7 5599.9 5640.3 5652.7 1165.6 1210.7 1317.6 1335.6 1336.2 662.1 833.5 857.0 877.3 911.2 4616.7 4812.7 4881.5 5225.6 5251.2 4981.1 5208.8 5544.7 5676.1 5732.3 4362.7 4876.9 5166.0 5168.4 5222.6 2559.3 2777.3 3018.0 3018.7 3020.2 4648.4 4850.9 4909.6 5180.6 5705.7 5540.0 5839.0 5914.9 5947.4 5951.8 4853.4 5302.3 5901.8 5964.4 5983.8 5143.5 5391.8 5525.8 5685.5 5820.9 5642.0 5729.0 5787.4 5791.4 5818.4 4963.6 5111.8 5186.7 5477.8 6020.4 3730.2 3848.2 3863.5 3881.9 3908.8 5058.9 5310.4 5513.5 5734.6 5745.1 5618.1 5647.2 5719.9 5739.9 5789.4 4807.7 5011.3 5551.3 5613.1 5703.5 4363.7 5040.5 5271.5 5517.8 5603.5 4602.7 4640.3 4750.0 4853.6 5361.4 5018.7 5340.8 5487.0 5522.6 5567.7 10:30:10 INFO - PROCESS | 2339 | 10:30:10 INFO - PROCESS | 2339 | [#5] yui.html Cycles:180 Average:24273.84 Median:3573.96 stddev:38264.34 (1070.6%) stddev-sans-first:38330.78 10:30:10 INFO - PROCESS | 2339 | Values: 712.3 735.8 748.2 785.2 792.7 15291.6 15964.6 16003.7 16013.6 16066.1 11972.5 14295.0 14378.9 14400.6 14850.4 681.2 701.7 832.6 837.5 869.2 820.3 831.9 832.4 833.0 841.2 922.7 923.6 924.5 926.3 926.6 722.5 742.1 743.8 916.5 917.0 561.9 672.1 689.4 696.1 703.4 14854.9 14859.9 14889.3 14891.4 14896.5 11516.0 13766.0 14033.2 14227.8 14366.2 12754.2 12800.1 12895.7 13277.3 13625.3 4538.0 4550.8 4560.5 4724.5 4751.0 110666.0 111775.3 112756.4 114647.0 117330.4 10942.1 10948.0 10958.7 11030.6 11468.8 21782.0 21824.3 21883.6 21909.1 22225.2 7202.3 7800.6 7801.0 7840.2 7853.5 4385.0 4411.1 4427.7 4471.5 4564.7 3469.9 3537.5 3571.0 3576.9 3579.9 669.9 670.4 671.5 678.9 723.8 564.8 592.9 616.1 658.6 691.0 8882.9 9290.6 9514.7 9536.9 9584.8 560.8 645.2 656.9 677.5 681.8 4334.8 4605.6 4631.1 4639.6 4714.9 88905.0 112909.0 138981.6 144465.3 149902.0 127588.0 127836.7 128804.0 129586.0 136239.0 85124.6 104035.5 104244.0 108261.0 108326.9 8791.6 8846.5 8857.4 8965.2 9074.4 59896.0 61115.0 61175.2 63728.0 65140.4 96571.6 97119.0 98899.0 100581.0 102454.5 11779.6 11812.6 11865.5 11941.9 11943.9 13169.7 13192.7 13193.8 13539.8 13626.0 9147.4 9202.1 12188.5 12432.4 12718.6 13132.6 13455.2 13789.8 13848.7 14118.2 13044.4 13229.9 13418.5 13653.6 13750.0 10801.6 10835.7 10970.8 11187.3 11308.5 10950.4 11257.1 11349.5 11493.0 11523.3 10:30:10 INFO - PROCESS | 2339 | -------- Summary: end -------- 10:30:10 INFO - PROCESS | 2339 | 10:30:11 INFO - TEST-INFO | 2339: exit 0 10:30:11 INFO - TEST-OK | dromaeo_css | took 1117758ms 10:30:11 INFO - TEST-START | kraken 10:30:11 INFO - operating with platform_type : mac_ 10:30:11 INFO - Initialising browser for kraken test... 10:30:11 INFO - TEST-INFO | started process 2342 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmplyxBNp/profile http://localhost:49530/getInfo.html) 10:30:13 INFO - PROCESS | 2342 | __metrics Screen width/height:1600/1200 10:30:13 INFO - PROCESS | 2342 | colorDepth:24 10:30:13 INFO - PROCESS | 2342 | Browser inner width/height: 1024/689 10:30:13 INFO - PROCESS | 2342 | __metrics 10:30:13 INFO - PROCESS | 2342 | 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:30:13 INFO - PROCESS | 2342 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:30:14 INFO - TEST-INFO | 2342: exit 0 10:30:14 INFO - Browser initialized. 10:30:14 INFO - Running cycle 1/1 for kraken test... 10:30:14 INFO - TEST-INFO | started process 2343 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmplyxBNp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:26 INFO - PROCESS | 2343 | RSS: Main: 234463232 10:30:26 INFO - PROCESS | 2343 | 10:30:28 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-beat-detection) 10:30:29 INFO - PROCESS | 2343 | RSS: Main: 292630528 10:30:29 INFO - PROCESS | 2343 | 10:30:32 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-dft) 10:30:33 INFO - PROCESS | 2343 | RSS: Main: 288165888 10:30:33 INFO - PROCESS | 2343 | 10:30:36 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-fft) 10:30:37 INFO - PROCESS | 2343 | RSS: Main: 377679872 10:30:37 INFO - PROCESS | 2343 | 10:30:39 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-oscillator) 10:30:40 INFO - PROCESS | 2343 | RSS: Main: 279769088 10:30:40 INFO - PROCESS | 2343 | 10:30:42 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49530/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:30:42 INFO - PROCESS | 2343 | RSS: Main: 283197440 10:30:42 INFO - PROCESS | 2343 | 10:30:45 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49530/tests/kraken/driver.html?testName=imaging-darkroom) 10:30:46 INFO - PROCESS | 2343 | RSS: Main: 322338816 10:30:46 INFO - PROCESS | 2343 | 10:30:49 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49530/tests/kraken/driver.html?testName=imaging-desaturate) 10:30:49 INFO - PROCESS | 2343 | RSS: Main: 323043328 10:30:49 INFO - PROCESS | 2343 | 10:30:52 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49530/tests/kraken/driver.html?testName=json-parse-financial) 10:30:53 INFO - PROCESS | 2343 | RSS: Main: 323301376 10:30:53 INFO - PROCESS | 2343 | 10:30:54 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49530/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:55 INFO - PROCESS | 2343 | RSS: Main: 299360256 10:30:55 INFO - PROCESS | 2343 | 10:30:57 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:57 INFO - PROCESS | 2343 | RSS: Main: 303325184 10:30:57 INFO - PROCESS | 2343 | 10:30:59 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:00 INFO - PROCESS | 2343 | RSS: Main: 306483200 10:31:00 INFO - PROCESS | 2343 | 10:31:03 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:04 INFO - PROCESS | 2343 | RSS: Main: 321155072 10:31:04 INFO - PROCESS | 2343 | 10:31:07 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:07 INFO - PROCESS | 2343 | RSS: Main: 317251584 10:31:07 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49530/tests/kraken/driver.html?testName=ai-astar) 10:31:09 INFO - PROCESS | 2343 | RSS: Main: 360804352 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | __start_tp_report 10:31:09 INFO - PROCESS | 2343 | _x_x_mozilla_page_load 10:31:09 INFO - PROCESS | 2343 | _x_x_mozilla_page_load_details 10:31:09 INFO - PROCESS | 2343 | |i|pagename|runs| 10:31:09 INFO - PROCESS | 2343 | |0;ai-astar;113;113;134;113;112;111;113;112;111;112 10:31:09 INFO - PROCESS | 2343 | |1;audio-beat-detection;147;115;132;162;108;134;154;137;150;121 10:31:09 INFO - PROCESS | 2343 | |2;audio-dft;185;183;185;183;185;182;186;182;260;194 10:31:09 INFO - PROCESS | 2343 | |3;audio-fft;79;73;75;156;58;57;56;69;148;71 10:31:09 INFO - PROCESS | 2343 | |4;audio-oscillator;82;81;136;69;70;90;120;69;69;118 10:31:09 INFO - PROCESS | 2343 | |5;imaging-gaussian-blur;87;85;88;71;135;131;89;85;87;84 10:31:09 INFO - PROCESS | 2343 | |6;imaging-darkroom;95;95;95;96;95;94;95;96;94;94 10:31:09 INFO - PROCESS | 2343 | |7;imaging-desaturate;84;83;86;83;86;84;83;85;85;86 10:31:09 INFO - PROCESS | 2343 | |8;json-parse-financial;52;51;54;53;51;53;53;52;52;51 10:31:09 INFO - PROCESS | 2343 | |9;json-stringify-tinderbox;68;67;72;69;72;75;73;72;71;72 10:31:09 INFO - PROCESS | 2343 | |10;stanford-crypto-aes;89;85;88;90;84;86;88;84;89;86 10:31:09 INFO - PROCESS | 2343 | |11;stanford-crypto-ccm;138;151;154;156;139;134;146;156;194;135 10:31:09 INFO - PROCESS | 2343 | |12;stanford-crypto-pbkdf2;170;167;174;167;167;169;166;168;166;190 10:31:09 INFO - PROCESS | 2343 | |13;stanford-crypto-sha256-iterative;68;68;69;68;68;67;66;67;67;66 10:31:09 INFO - PROCESS | 2343 | __end_tp_report 10:31:09 INFO - PROCESS | 2343 | __start_cc_report 10:31:09 INFO - PROCESS | 2343 | _x_x_mozilla_cycle_collect,2092 10:31:09 INFO - PROCESS | 2343 | __end_cc_report 10:31:09 INFO - PROCESS | 2343 | __startTimestamp1472664669731__endTimestamp 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | ------- Summary: start ------- 10:31:09 INFO - PROCESS | 2343 | Number of tests: 14 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#0] ai-astar Cycles:10 Average:114.40 Median:113.00 stddev:6.93 (6.1%) stddev-sans-first:7.33 10:31:09 INFO - PROCESS | 2343 | Values: 113.0 113.0 134.0 113.0 112.0 111.0 113.0 112.0 111.0 112.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:142.00 stddev:17.60 (12.4%) stddev-sans-first:18.21 10:31:09 INFO - PROCESS | 2343 | Values: 147.0 115.0 132.0 162.0 108.0 134.0 154.0 137.0 150.0 121.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#2] audio-dft Cycles:10 Average:192.50 Median:185.00 stddev:23.97 (13.0%) stddev-sans-first:25.27 10:31:09 INFO - PROCESS | 2343 | Values: 185.0 183.0 185.0 183.0 185.0 182.0 186.0 182.0 260.0 194.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#3] audio-fft Cycles:10 Average:84.20 Median:70.00 stddev:36.65 (52.4%) stddev-sans-first:38.83 10:31:09 INFO - PROCESS | 2343 | Values: 79.0 73.0 75.0 156.0 58.0 57.0 56.0 69.0 148.0 71.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:69.50 stddev:25.09 (36.1%) stddev-sans-first:26.43 10:31:09 INFO - PROCESS | 2343 | Values: 82.0 81.0 136.0 69.0 70.0 90.0 120.0 69.0 69.0 118.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:86.00 stddev:21.08 (24.5%) stddev-sans-first:22.20 10:31:09 INFO - PROCESS | 2343 | Values: 87.0 85.0 88.0 71.0 135.0 131.0 89.0 85.0 87.0 84.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:31:09 INFO - PROCESS | 2343 | Values: 95.0 95.0 95.0 96.0 95.0 94.0 95.0 96.0 94.0 94.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:1.27 (1.5%) stddev-sans-first:1.33 10:31:09 INFO - PROCESS | 2343 | Values: 84.0 83.0 86.0 83.0 86.0 84.0 83.0 85.0 85.0 86.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.03 (2.0%) stddev-sans-first:1.09 10:31:09 INFO - PROCESS | 2343 | Values: 52.0 51.0 54.0 53.0 51.0 53.0 53.0 52.0 52.0 51.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:72.00 stddev:2.42 (3.4%) stddev-sans-first:2.30 10:31:09 INFO - PROCESS | 2343 | Values: 68.0 67.0 72.0 69.0 72.0 75.0 73.0 72.0 71.0 72.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:88.00 stddev:2.18 (2.5%) stddev-sans-first:2.18 10:31:09 INFO - PROCESS | 2343 | Values: 89.0 85.0 88.0 90.0 84.0 86.0 88.0 84.0 89.0 86.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:152.50 stddev:17.59 (11.5%) stddev-sans-first:18.09 10:31:09 INFO - PROCESS | 2343 | Values: 138.0 151.0 154.0 156.0 139.0 134.0 146.0 156.0 194.0 135.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:168.50 stddev:7.29 (4.3%) stddev-sans-first:7.73 10:31:09 INFO - PROCESS | 2343 | Values: 170.0 167.0 174.0 167.0 167.0 169.0 166.0 168.0 166.0 190.0 10:31:09 INFO - PROCESS | 2343 | 10:31:09 INFO - PROCESS | 2343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 10:31:09 INFO - PROCESS | 2343 | Values: 68.0 68.0 69.0 68.0 68.0 67.0 66.0 67.0 67.0 66.0 10:31:09 INFO - PROCESS | 2343 | -------- Summary: end -------- 10:31:09 INFO - PROCESS | 2343 | 10:31:10 INFO - TEST-INFO | 2343: exit 0 10:31:10 INFO - TEST-OK | kraken | took 59218ms 10:31:10 INFO - SUITE-END | took 1176s 10:31:10 INFO - Completed test suite (00:19:37) 10:31:10 INFO - javascript benchmark 10:31:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3261.7716759826812, 3320.136764441245, 3323.783954042987, 3343.2143446290133, 3393.949090763639, 5523.226748255248, 5601.467860553241, 5641.943580564193, 5722.227499287595, 5749.482546570808, 5642.294713160855, 5668.801591944282, 5694.77220911163, 5696.629719068258, 5713.17159011943, 5120.513551212647, 5163.845084647466, 5171.974140129313, 5174.275601415805, 5239.083160446926, 5226.608004399666, 5237.371515418136, 5239.895202095956, 5255.290535777678, 5287.524122828944, 4326.286162783153, 5198.584113270948, 5216.400113986883, 5235.057689615867, 5246.737663116829, 5262.842114736545, 5292.417834038252, 5294.338207724035, 5303.124984377573, 5352.437994010612, 4151.418801367811, 5111.795528178868, 5150.407703114115, 5203.713795741232, 5211.817586384496, 5586.24585680932, 5640.153976903456, 5700.0, 5705.144228365778, 5716.256886604757, 6194.163787888622, 6197.442230199304, 6203.5037197024585, 6212.347703491158, 6236.781712640036, 6087.4521293083835, 6177.907331390033, 6198.659073750942, 6244.1570387997945, 6254.21822272216, 5796.768129274824, 5804.854878628068, 5860.09168578871, 5871.383504731984, 5889.234399528034, 6271.592346497463, 6285.779997700059, 6292.150559674477, 6302.0, 6304.148939893055, 6005.159277701126, 6052.799744388505, 6080.9391906081255, 6151.477124444473, 6159.907601385983, 6155.753769849156, 6241.469475094577, 6243.063540468966, 6254.468370188585, 6257.311695713468, 6142.57002009855, 6190.597611155261, 6199.442050215503, 6200.596961197508, 6209.285932117864, 6086.543509236736, 6091.8172454825535, 6101.694915254219, 6219.657918814509, 6229.314775374705, 4948.4061912570005, 4953.504649535018, 4975.353204083446, 4979.45226025137, 5006.173981293119, 4465.59809617136, 4474.217012022883, 4492.9550704493195, 4502.707324023993, 4543.477500087466, 5710.571707121982, 5719.799807006818, 5725.627834190847, 5726.742296596663, 5741.684207368551, 6099.007149909933, 6192.8761424771255, 6198.2252218472695, 6233.189685340877, 6267.059941008794, 5705.885882282331, 5723.027085395493, 5730.684812335361, 5736.71316434185, 5800.622959507618, 5456.345238571317, 5465.781368745285, 5466.890662186734, 5468.179773033997, 5491.176323551499, 5850.6782126981725, 6143.082036033027, 6258.687065646791, 6298.748050077946, 6314.652694101868, 6268.216472940882, 6283.308836027942, 6283.7800676976085, 6286.622802631857, 6287.182666253358, 5417.268668729828, 6245.376202187555, 6292.842678933063, 6305.464035556845, 6324.083007963912, 6021.729022194099, 6099.915141108964, 6138.877222455615, 6161.784337548164, 6213.782517611862, 6158.414950579688, 6225.688715564113, 6231.22109736283, 6258.499320054476, 6266.874662506633, 6114.816555503342, 6131.60144590618, 6144.907826382519, 6148.907766383597, 6150.04674275488, 6007.12896629995, 6098.664573448503, 6104.847378815565, 6144.1398204250545, 6195.256569211543, 5961.344252132175, 6007.038873780349, 6010.9699451502465, 6043.45608895184, 6054.091886217103, 6109.541784366279, 6131.172291740558, 6138.693065346625, 6142.508599311955, 6189.133521307111, 5812.622179558315, 5858.209141765978, 5921.585489015728, 5986.850328741816, 5992.490638295793], "value": 5688.769370986265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.44453045019856, 488.79226328810256, 500.65955150497695, 528.7964133808482, 548.3611592494743, 30983.690163098363, 39932.80033599835, 41069.0, 41149.58850411495, 41204.0, 42361.0, 42748.358774618326, 42839.357409638804, 42859.57140428595, 42928.0, 8753.912460875405, 9617.807643847136, 9830.26273029522, 9860.408375497458, 9863.112319891208, 8815.382923195379, 8952.239059679934, 8962.058983806672, 9002.729918102468, 11798.292102473835, 11942.104342174329, 12273.509059637603, 12352.567660131897, 12357.011439084896, 12371.628851134481, 12262.50949962005, 12339.568115116017, 12353.62939111828, 12354.320512371816, 12385.318807465675, 12065.215760975509, 12099.274043557414, 12102.334371609559, 12105.45525451348, 12148.635540933787, 40391.39412908809, 40697.38953915694, 40726.592734072874, 40739.98150046243, 40808.77573672795, 3352.0, 3464.22055037617, 3531.04661741331, 3583.62371950944, 4076.5719599441927, 30074.69925300741, 31007.0, 31301.37397252065, 31372.686273137206, 31853.681463185305, 3272.8199949003033, 3278.7704860659765, 3339.666033396665, 3354.127926739041, 3381.340638575479, 498286.0, 503616.4819175917, 505517.0, 509124.0, 518325.0, 57167.42832571621, 57333.0, 57465.13802292969, 57481.425185747605, 57581.13628295579, 34027.0, 34743.0, 34746.30507389838, 35951.28097438037, 36039.81980090083, 16285.511434656979, 16455.83544164567, 16462.917685411496, 16485.752713709306, 16501.752473712902, 12557.874421255854, 12673.04952128594, 12683.556075537312, 12695.047871409497, 12695.746085078246, 15969.680606387807, 16276.26756795947, 17033.659326813642, 17522.649547008987, 18428.631427371376, 6112.965442807815, 7520.924790752022, 7685.884711729329, 7712.0412849749955, 7774.572398518023, 757.6704133701858, 874.8337815815102, 907.1291560102376, 928.9262267830422, 1134.387430787382, 29417.411651766844, 29921.251968700522, 29960.0, 30534.694653053186, 30554.38891222163, 1034.3121823987115, 1066.5094056733835, 1108.4236197177422, 1120.7422292872523, 1122.1023181454802, 14884.851151488563, 15483.303251353716, 15545.222738863238, 15651.0, 15882.76175857363, 684926.0, 690603.0, 694163.0, 694633.0, 697188.0, 48762.780930476314, 49614.0, 49954.75022624864, 51899.22151167736, 58908.11637825436, 1358.5109360630165, 1368.4594585138814, 1368.7134093951654, 1388.902776805614, 1391.1027387335112, 30457.0, 30953.535696964114, 31129.8443507781, 31368.68631313749, 31628.0, 48370.274445884046, 48669.02661946812, 48797.0, 48863.511364887316, 48900.75549622229, 593813.0, 594577.0, 595808.0, 597872.0, 662428.0, 39772.80113599414, 40157.795266142064, 40564.594354056084, 40829.79585102056, 41133.58866411298, 44965.0, 45227.32159017552, 45556.0, 45745.54254457413, 45946.85132871571, 35036.0, 37366.252674945805, 37845.62154378421, 38676.41985370166, 38957.80521097376, 37314.88055358343, 37587.62412375951, 38027.80986095052, 38500.0, 38959.6104038956, 36023.63976360203, 36931.81534092312, 36993.0, 37187.442188367735, 37579.436308454846, 32165.874194403084, 33215.501767473994, 33230.0, 33401.49897751487, 33488.49767253542, 24830.37924051841, 25239.62140567856, 25712.0, 25950.48099037971, 26521.867390662923], "value": 20209.190787350413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.22915273855733, 372.64598631300265, 374.07043496910154, 386.6018001458498, 404.31266846361194, 15541.689166216684, 15705.309252325695, 20479.385618431435, 20757.792422075774, 20888.373348799523, 20897.0, 21132.577348453022, 21494.098296729935, 21777.020034098463, 21810.89094554525, 5879.853003674921, 5931.466168044875, 6043.818685439422, 6152.292486364058, 6186.84532886677, 4181.289180839264, 6011.158437818709, 6097.176881121059, 6111.327753947062, 6478.3845534674365, 6776.390124888759, 6788.592684438925, 6797.52417330787, 6816.420604248645, 6883.174019117688, 6583.703733331988, 6666.567106226006, 6710.5302628816, 6760.797176084725, 6802.319768023208, 5654.6041777075625, 5869.207656966298, 5879.588428809985, 5891.646501209898, 5901.0, 19601.9019904901, 26664.93340266387, 26865.597016044776, 27068.59397109045, 27073.32316692079, 2415.9154429595055, 2606.5568853294985, 2954.2762023304213, 3067.9846600767078, 3203.759718021158, 15486.845131548653, 15673.373065077383, 15963.680726385523, 15970.840291597167, 16104.83895161045, 1878.6994080946984, 1912.8660993730305, 1919.221276952112, 1928.643201007818, 1980.3464856597288, 111929.68773434915, 117070.0, 117094.0, 117879.0, 123940.0, 10725.0, 10895.509702063426, 11016.669499915015, 11184.888151118548, 11297.49161287744, 11357.716057098638, 13841.653958651113, 13861.930690346484, 13867.514636987657, 13870.959678024188, 8570.4000719949, 8703.173198546128, 8722.520261385685, 8729.563521823884, 8881.866771998426, 6675.833104172434, 8124.512529248264, 8808.295336373074, 8838.911610883808, 9032.63869445228, 6038.973374526341, 6084.5436592255755, 6349.936500634934, 6705.228898676617, 6712.328767123248, 1673.6820004199162, 1760.1991094052175, 1850.1581780289937, 1875.7655293088364, 1897.297999740105, 899.6311512279934, 921.8386782313069, 986.4032260482448, 1010.8281592129356, 1101.1851230089835, 21731.891340543196, 22078.558428831653, 22267.55464890693, 22276.443088922908, 22329.888350558143, 933.7618907178762, 978.280963491833, 982.2633025231077, 985.8176237396104, 1017.5726194998118, 11343.43282835855, 11569.132315076404, 11859.58491452795, 11926.46330915111, 11931.343776092224, 564599.0, 569406.0, 578086.0, 583731.0, 586077.0, 84790.0, 114412.28381574283, 119173.0, 119700.0, 136050.0, 784.584170389683, 970.4371464550403, 1000.049952545085, 1000.8148492528906, 1002.734275417015, 17486.0, 18390.89654620727, 18629.975351355806, 19204.135813888686, 19229.94235317071, 36742.0175752518, 51903.480965191375, 53041.7347913258, 53691.194632079765, 53821.0, 54367.0, 77001.14994250154, 77919.0, 78128.26551070686, 79658.60170699109, 6292.905606415999, 7898.2891539761695, 7993.0, 8048.034235891496, 8112.391570632109, 11151.72120696989, 11812.527498900292, 12413.93793031029, 12800.10399272042, 12950.481980720666, 8923.884514435695, 11182.384968826467, 11239.55041798319, 11329.71675708114, 11403.486843092247, 10582.153427725609, 10714.785704285714, 11058.391788451712, 11171.38557379352, 11339.886601133883, 11030.393328367018, 11182.161337899854, 11183.944080279873, 11411.25826821254, 11482.77034459323, 5920.644761314335, 7826.41301902371, 7914.24814642608, 8298.63488905659, 8373.288270497076, 9574.664886728931, 10992.780144396907, 11071.83392249133, 11303.71740706456, 11328.9433552835], "value": 9813.001944133131, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.6032190342894, 1476.1512130524948, 1487.9479218227361, 1702.4892532240324, 1918.6834172361562, 7921.84156316874, 8653.09142540033, 9139.908600913997, 9145.817083658323, 9252.444853308789, 8972.416792908456, 9100.362974591764, 9103.908960910405, 9111.908880911189, 9118.544072796367, 2389.9880500597515, 2427.5630386530506, 2428.138011006094, 2430.2466235467064, 2430.6111022236446, 2349.694539709835, 2400.8919598618104, 2402.3633737059695, 2403.5072810073893, 2407.1334319644916, 2383.249276477904, 2399.124319623342, 2415.758424157579, 2415.891284892184, 2417.721961974369, 1949.7465329507145, 2347.260612906929, 2382.3686723018327, 2387.4747555537756, 2397.2568503763714, 2347.2136834160406, 2372.50177462733, 2375.1568193291478, 2375.394274460019, 2382.54731600997, 8670.52312122833, 9046.231070359026, 9121.270298376114, 9127.863082053775, 9128.726138215865, 5240.554552863011, 5445.455454454523, 5462.590305727047, 5478.986387518322, 5480.862978425532, 3644.2893635741043, 3686.5760437549757, 3690.0221441317804, 3752.774833509998, 3763.4354846773203, 1081.5835903177256, 1098.1873413673904, 1099.6316234061599, 1106.623747925701, 1114.2311804854623, 11796.882031179664, 11815.940920295343, 11874.465649045813, 11899.524019039314, 11900.285982841056, 4362.541933097043, 4487.753173575485, 4614.930776038362, 4658.394408726844, 4691.296305554194, 9144.3598948073, 9145.725628231165, 9156.908430915739, 9163.266938644892, 9177.724668259963, 5255.973720131375, 5256.6057545684225, 5258.2638430619745, 5265.447128051576, 5265.842024739264, 4447.3329000650165, 4612.76936153191, 4796.424429068465, 4940.604751619861, 4943.9258411123865, 3718.2935242303874, 3732.4401339799247, 3825.464434979105, 3851.826667799956, 3870.7871067091583, 1175.1010476985114, 1185.5020891225706, 1187.0503597122267, 1196.4376742930983, 1203.3562044306254, 905.1265528764774, 917.8623206518942, 918.1094338491653, 944.7326416600215, 981.3621146254849, 5663.377028526858, 5967.254093238345, 5988.305262631746, 6163.075538669235, 6170.136180934673, 439.9538048504861, 448.7195502810743, 461.11926220918554, 461.3448902558375, 462.00438055988724, 3941.802909854553, 3998.7800670962793, 4022.9741415938747, 4058.066644671683, 4081.673466122703, 10310.484475776331, 10680.359178449318, 10761.677149685522, 10973.177011724152, 10983.39591322469, 10774.760902496313, 10836.566537338418, 10900.182486313559, 10905.890941090645, 10906.945465272782, 6903.6548172591165, 8341.04078031022, 8356.164383561716, 8361.0, 8364.958175209207, 5895.94104058954, 5982.670953097621, 6066.15073889647, 6119.632822030692, 6121.265448146251, 9629.759256018655, 10175.440350780778, 10185.694429167137, 10249.386406466303, 10258.333208341433, 10181.898181018096, 10331.380117192992, 10331.741706457398, 10357.689269321932, 10365.378077315385, 6860.2453730088655, 6965.616891071039, 7478.4765066444825, 7479.626018699152, 7644.15914249421, 8288.088310285984, 8515.318774497902, 8526.147385261673, 8541.273991710774, 8544.060153383247, 7513.211112833293, 7665.271799179069, 7682.7311044113185, 7725.343345815669, 7782.338501227459, 7379.446541509301, 7467.066616672916, 7481.887771683538, 7497.737579184921, 7514.098308203051, 7002.509824312249, 7126.322999315057, 7128.073350464407, 7131.500794944512, 7151.678174482265, 4906.313116163668, 5063.113955057924, 5073.746312684425, 5106.514881086291, 5147.536721695065, 4941.802327906844, 4974.801007959786, 5112.897742045213, 5143.382794064736, 5243.528082472443], "value": 4531.434464866019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.3384619989822, 302.3952095808383, 310.36530295545634, 311.15521359508926, 315.11924171939427, 4213.578642135785, 5370.2750128732605, 5397.649152805065, 5403.8108666196595, 5451.291332126828, 4938.6542941993985, 4958.702477851331, 4964.925526117102, 5217.269652198677, 5277.419483856773, 3553.1294832766007, 3977.3636218205093, 4026.074002979309, 4039.1719697462095, 4058.959410405888, 3690.6493883081066, 3907.2771537265553, 4051.4604450308843, 4090.2433049885717, 4104.8358065677485, 3300.290437555925, 3769.1907884215593, 3995.841206050242, 4005.2590270799997, 4016.959830401702, 3732.346839303125, 4044.676425885922, 4067.6542493888055, 4080.6327430531096, 4090.6318431341024, 2940.7354837419903, 3252.9186770330693, 3412.8805491807916, 3538.8938331850086, 3561.5013898054294, 4059.4925634295714, 4306.80619372129, 5155.639105262633, 5181.119209734355, 5202.401723801773, 4318.395424640553, 4524.11779702958, 4607.723536587782, 4612.515685852971, 4639.512851150615, 4376.102898905717, 5506.724663766796, 5509.669419834822, 5513.959834861087, 5540.667559946376, 3859.3019071608683, 3870.9225815483533, 3890.455336252927, 3898.6881049516255, 3919.647231749156, 4406.383106365111, 5153.016088805799, 5476.808311709111, 5835.212246346731, 5848.093545500455, 3415.6849612899214, 3856.4547398716713, 3932.2332145231403, 3939.6060393960374, 3968.583298753647, 3972.205558888234, 4023.517177938666, 4034.8184331705143, 4053.412255223035, 4070.7354021988476, 4192.748435093904, 4521.909561808746, 4590.8163673453355, 4702.36518070063, 4706.576408123286, 5299.4435584263865, 5459.69971651563, 5599.852030333772, 5640.266765320482, 5652.689102099424, 1165.6444784340858, 1210.7396909664465, 1317.6047185844209, 1335.599320203935, 1336.1982810313734, 662.0995446193174, 833.5496236548362, 856.9742907712779, 877.3244601656817, 911.2026976395654, 4616.699914505613, 4812.735299558558, 4881.4630390657, 5225.608079394061, 5251.159814429673, 4981.103401387712, 5208.817691380784, 5544.7227638618715, 5676.148577713376, 5732.34078081026, 4362.738235705868, 4876.902461950812, 5165.985265746362, 5168.431472538018, 5222.556082732935, 2559.3473664215876, 2777.3195567086195, 3017.9547306790414, 3018.7170452557575, 3020.2147441665325, 4648.395708557933, 4850.854474365775, 4909.558139767438, 5180.559652429511, 5705.657660540381, 5539.972300138474, 5839.0, 5914.9112763308585, 5947.37552556984, 5951.7619295227705, 4853.369062021985, 5302.337207849019, 5901.76392944286, 5964.373740757158, 5983.790567330123, 5143.537081662668, 5391.757370918396, 5525.806596769094, 5685.459881311269, 5820.941790582209, 5642.0, 5728.968785618628, 5787.421257874347, 5791.391903850035, 5818.359980402068, 4963.602911766978, 5111.795528178831, 5186.662866913639, 5477.835664930059, 6020.397960203944, 3730.2353017630776, 3848.2303539291693, 3863.497745293094, 3881.902952426212, 3908.8045597719433, 5058.9494105058475, 5310.362756469249, 5513.5037846594, 5734.569907256889, 5745.138229265476, 5618.129189975561, 5647.15292706081, 5719.8856022880145, 5739.9139012914, 5789.421057894177, 4807.663463557657, 5011.298418221525, 5551.278333816578, 5613.073842815889, 5703.543716502752, 4363.694541382073, 5040.463582775531, 5271.525562699376, 5517.751701173537, 5603.467670571289, 4602.654800890014, 4640.303954406866, 4750.0, 4853.611711063036, 5361.410244873139, 5018.723970181675, 5340.839774806762, 5487.0, 5522.591739106502, 5567.721613919207], "value": 4023.6855369462237, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.3019440947871, 735.7682330066028, 748.2181120728841, 785.2304741353473, 792.7066985215471, 15291.617709557268, 15964.600884977852, 16003.679926401494, 16013.599660008505, 16066.116363599982, 11972.521099156045, 14295.0, 14378.928105359459, 14400.567982960501, 14850.405983760664, 681.2200030964542, 701.6877489517167, 832.6378025558886, 837.4723923927917, 869.1786261982429, 820.2535692519808, 831.9001719793603, 832.3507664022043, 832.9958350208241, 841.1756478650926, 922.7185708358948, 923.5751554285036, 924.5469719837265, 926.2775035472342, 926.6154545863492, 722.4762047515509, 742.0946445336681, 743.8363560016787, 916.4913473022469, 916.9541522923861, 561.9241402410663, 672.092674888901, 689.3657834792003, 696.1298377028714, 703.4231929817552, 14854.851451485454, 14859.925700371537, 14889.329980150918, 14891.404343826234, 14896.478623248135, 11516.021138203263, 13766.0, 14033.228172450512, 14227.78658320126, 14366.20985845778, 12754.170978886435, 12800.103992720513, 12895.742085158337, 13277.336133193301, 13625.318734063356, 4537.954620453786, 4550.840720574764, 4560.452745670541, 4724.456687480915, 4750.976245118787, 110666.0, 111775.3233701487, 112756.43621781921, 114647.0, 117330.41334793271, 10942.124630029579, 10948.0, 10958.671239862817, 11030.558777648965, 11468.827967580493, 21782.0, 21824.345269641937, 21883.562328753334, 21909.12363505442, 22225.222117225818, 7202.315780000891, 7800.609969501502, 7801.0, 7840.215978402114, 7853.528788272722, 4385.035292235703, 4411.073674528385, 4427.69006169565, 4471.463424389029, 4564.748938808398, 3469.8785542505893, 3537.4870643756512, 3571.0, 3576.91057723559, 3579.8926032219074, 669.8961660942562, 670.3564578005072, 671.4661843834164, 678.9117414736053, 723.7539236659561, 564.7599770097775, 592.9051351783694, 616.0605077257129, 658.578509753758, 690.9619970901548, 8882.86675699865, 9290.581923813445, 9514.666986655433, 9536.904630953602, 9584.760380990392, 560.8317504748641, 645.2225068792094, 656.8981807819796, 677.4749569083999, 681.7852376501386, 4334.804933777988, 4605.608523275492, 4631.050078690096, 4639.559241872017, 4714.882127946828, 88905.0, 112909.0, 138981.61018389688, 144465.27767361305, 149902.0, 127588.0, 127836.72163278435, 128804.0, 129586.0, 136239.0, 85124.57437712772, 104035.4798226004, 104243.95756042494, 108261.0, 108326.90940016256, 8791.648334066565, 8846.456340159477, 8857.3799834011, 8965.197862773482, 9074.364794464323, 59896.0, 61115.0, 61175.188357106, 63728.04407933977, 65140.371490711215, 96571.55142673006, 97119.028809711, 98899.01100989185, 100581.0, 102454.48772756387, 11779.587714429954, 11812.586559470377, 11865.525378985089, 11941.880581194077, 11943.880561194625, 13169.670758231121, 13192.67018324511, 13193.80209296842, 13539.79006923241, 13626.0, 9147.359684821999, 9202.089705654944, 12188.51245950152, 12432.378381080729, 12718.618441446772, 13132.606021819362, 13455.245046510183, 13789.793153102511, 13848.723025539633, 14118.21153327131, 13044.413001414769, 13229.867701323248, 13418.530351437652, 13653.590392288248, 13750.0, 10801.567937282422, 10835.729106772395, 10970.780584388109, 11187.272827266203, 11308.547658093585, 10950.397728124712, 11257.10865010489, 11349.48927298257, 11493.0, 11523.250988685708], "value": 7739.9294109523835, "unit": "score"}], "name": "dromaeo_css", "value": 7362.110220422285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 134.0, 113.0, 112.0, 111.0, 113.0, 112.0, 111.0, 112.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 132.0, 162.0, 108.0, 134.0, 154.0, 137.0, 150.0, 121.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 185.0, 183.0, 185.0, 182.0, 186.0, 182.0, 260.0, 194.0], "value": 192.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 75.0, 156.0, 58.0, 57.0, 56.0, 69.0, 148.0, 71.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 136.0, 69.0, 70.0, 90.0, 120.0, 69.0, 69.0, 118.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 71.0, 135.0, 131.0, 89.0, 85.0, 87.0, 84.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 86.0, 83.0, 86.0, 84.0, 83.0, 85.0, 85.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 54.0, 53.0, 51.0, 53.0, 53.0, 52.0, 52.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 72.0, 69.0, 72.0, 75.0, 73.0, 72.0, 71.0, 72.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 90.0, 84.0, 86.0, 88.0, 84.0, 89.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 151.0, 154.0, 156.0, 139.0, 134.0, 146.0, 156.0, 194.0, 135.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 174.0, 167.0, 167.0, 169.0, 166.0, 168.0, 166.0, 190.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1489.4000000000003, "alertThreshold": 2.0}]} 10:31:10 INFO - Return code: 0 10:31:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:31:11 INFO - # TBPL SUCCESS # 10:31:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:31:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:31:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:31:11 INFO - 2016-08-31 10:31:11.066 screenresolution[2347:16945] starting screenresolution argv=screenresolution get 10:31:11 INFO - 2016-08-31 10:31:11.069 screenresolution[2347:16945] Display 0: 1600x1200x32@60 10:31:11 INFO - 2016-08-31 10:31:11.075 screenresolution[2348:16948] starting screenresolution argv=screenresolution list 10:31:11 INFO - Available Modes on Display 0 10:31:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:31:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:31:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:31:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:31:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:31:11 INFO - Intel Iris: 10:31:11 INFO - Chipset Model: Intel Iris 10:31:11 INFO - Type: GPU 10:31:11 INFO - Bus: Built-In 10:31:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:31:11 INFO - Vendor: Intel (0x8086) 10:31:11 INFO - Device ID: 0x0a2e 10:31:11 INFO - Revision ID: 0x0009 10:31:11 INFO - Displays: 10:31:11 INFO - Display: 10:31:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:31:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:31:11 INFO - Display Serial Number: 1600x1200 60 10:31:11 INFO - Main Display: Yes 10:31:11 INFO - Mirror: Off 10:31:11 INFO - Online: Yes 10:31:11 INFO - Rotation: Supported 10:31:11 INFO - Return code: 0 10:31:11 INFO - Running post-action listener: _resource_record_post_action 10:31:11 INFO - [mozharness: 2016-08-31 17:31:11.310988Z] Finished run-tests step (success) 10:31:11 INFO - Running post-run listener: _resource_record_post_run 10:31:11 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 352256; Write bytes: 706496512; Read time: 5; Write time: 2023 10:31:11 INFO - TinderboxPrint: CPU usage
53.5% 10:31:11 INFO - TinderboxPrint: I/O read bytes / time
352,256 / 5 10:31:11 INFO - TinderboxPrint: I/O write bytes / time
706,496,512 / 2,023 10:31:11 INFO - TinderboxPrint: CPU idle
2,254.2 (46.5%) 10:31:11 INFO - TinderboxPrint: CPU system
968.4 (20.0%) 10:31:11 INFO - TinderboxPrint: CPU user
1,627.0 (33.5%) 10:31:11 INFO - TinderboxPrint: Swap in / out
405,639,168 / 0 10:31:11 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404879872; Write bytes: 400553472; Read time: 29680; Write time: 864 10:31:11 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 172032; Write bytes: 295289344; Read time: 2; Write time: 1127 10:31:11 INFO - Running post-run listener: _upload_blobber_files 10:31:11 INFO - Blob upload gear active. 10:31:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:31:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:31:12 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:12 INFO - (blobuploader) - INFO - Done attempting. 10:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:13 INFO - (blobuploader) - INFO - Done attempting. 10:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:31:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:16 INFO - (blobuploader) - INFO - Done attempting. 10:31:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:16 INFO - Return code: 0 10:31:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cb71e56ad61e72d20c30dc1d447002a3fad96bc70fe7d9949ab65ddc7520a5f08472333f47114733d39f6661d4edfd4d76708aab1da72c7af86d866f29622ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/166533f14ec83e902a61d5ac47a6c156ce395cfc7bdbc8febd5da45252cb80eb5850cc610807385a547755bbfee28542e52f7585d463ef76a8b5c98b8d52849b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb1d9c9fe81a4bbce6778f91a8c8fb472f236e93d32e1426e210f54205cad438219e444c2eafa7e4365f32cbbfd21c5b9680f734398ab7deb34541d3c824a52f"} 10:31:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:16 INFO - Contents: 10:31:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cb71e56ad61e72d20c30dc1d447002a3fad96bc70fe7d9949ab65ddc7520a5f08472333f47114733d39f6661d4edfd4d76708aab1da72c7af86d866f29622ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/166533f14ec83e902a61d5ac47a6c156ce395cfc7bdbc8febd5da45252cb80eb5850cc610807385a547755bbfee28542e52f7585d463ef76a8b5c98b8d52849b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb1d9c9fe81a4bbce6778f91a8c8fb472f236e93d32e1426e210f54205cad438219e444c2eafa7e4365f32cbbfd21c5b9680f734398ab7deb34541d3c824a52f"} 10:31:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:16 INFO - Copying logs to upload dir... 10:31:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.696076 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-31 10:31:16.264185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 10:31:16.267399) ========= 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.3kZ8fknUh3/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.U32UhZUlFH/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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/2cb71e56ad61e72d20c30dc1d447002a3fad96bc70fe7d9949ab65ddc7520a5f08472333f47114733d39f6661d4edfd4d76708aab1da72c7af86d866f29622ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/166533f14ec83e902a61d5ac47a6c156ce395cfc7bdbc8febd5da45252cb80eb5850cc610807385a547755bbfee28542e52f7585d463ef76a8b5c98b8d52849b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb1d9c9fe81a4bbce6778f91a8c8fb472f236e93d32e1426e210f54205cad438219e444c2eafa7e4365f32cbbfd21c5b9680f734398ab7deb34541d3c824a52f"} build_url:https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/Aq5E0hGLQFifOWkOxoa1ug/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/2cb71e56ad61e72d20c30dc1d447002a3fad96bc70fe7d9949ab65ddc7520a5f08472333f47114733d39f6661d4edfd4d76708aab1da72c7af86d866f29622ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/166533f14ec83e902a61d5ac47a6c156ce395cfc7bdbc8febd5da45252cb80eb5850cc610807385a547755bbfee28542e52f7585d463ef76a8b5c98b8d52849b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb1d9c9fe81a4bbce6778f91a8c8fb472f236e93d32e1426e210f54205cad438219e444c2eafa7e4365f32cbbfd21c5b9680f734398ab7deb34541d3c824a52f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 10:31:16.302085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:31:16.302432) ========= 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.3kZ8fknUh3/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.U32UhZUlFH/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.005156 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:31:16.351288) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 10:31:16.351626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 10:31:16.352011) ========= ========= Total master_lag: 0.18 =========