builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1471883039.96 results: success (0) buildid: 20160822064220 builduid: f13a8455ecd24782bc55d6436cef10f3 revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:23:59.955932) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:23:59.956428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:23:59.956767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:23:59.979954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:23:59.980246) ========= 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.ogvqUt0G09/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.sNmigzm8zh/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-22 09:23:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.47M=0.001s 2016-08-22 09:24:00 (8.47 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093982 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:24:00.097028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:24:00.097398) ========= 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.ogvqUt0G09/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.sNmigzm8zh/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.021569 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:24:00.146914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 09:24:00.147279) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --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 194fe275b4e60ded2af6b25173eec421f0dba8ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ogvqUt0G09/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.sNmigzm8zh/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-22 09:24:00,217 truncating revision to first 12 chars 2016-08-22 09:24:00,217 Setting DEBUG logging. 2016-08-22 09:24:00,217 attempt 1/10 2016-08-22 09:24:00,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/194fe275b4e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 09:24:00,950 unpacking tar archive at: fx-team-194fe275b4e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985269 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 09:24:01.157664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:24:01.158096) ========= script_repo_revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:24:01.158495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:24:01.158824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:24:01.178319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-22 09:24:01.178924) ========= /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.ogvqUt0G09/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.sNmigzm8zh/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:01 INFO - MultiFileLogger online at 20160822 09:24:01 in /builds/slave/test 09:24:01 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 09:24:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:01 INFO - {'append_to_log': False, 09:24:01 INFO - 'base_work_dir': '/builds/slave/test', 09:24:01 INFO - 'blob_upload_branch': 'Fx-Team', 09:24:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:01 INFO - 'branch': 'Fx-Team', 09:24:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:01 INFO - 'config_files': ('talos/mac_config.py',), 09:24:01 INFO - 'default_actions': ('clobber', 09:24:01 INFO - 'read-buildbot-config', 09:24:01 INFO - 'download-and-extract', 09:24:01 INFO - 'populate-webroot', 09:24:01 INFO - 'create-virtualenv', 09:24:01 INFO - 'install', 09:24:01 INFO - 'run-tests'), 09:24:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:01 INFO - 'download_minidump_stackwalk': True, 09:24:01 INFO - 'download_symbols': 'ondemand', 09:24:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:01 INFO - 'installer_path': 'installer.exe', 09:24:01 INFO - 'log_level': 'info', 09:24:01 INFO - 'log_name': 'talos', 09:24:01 INFO - 'log_to_console': True, 09:24:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:24:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:24:01 INFO - 'opt_config_files': (), 09:24:01 INFO - 'pip_index': False, 09:24:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:01 INFO - 'cmd': ('bash', 09:24:01 INFO - '-c', 09:24:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:01 INFO - 'enabled': True, 09:24:01 INFO - 'halt_on_failure': False, 09:24:01 INFO - 'name': 'check_screen_resolution'},), 09:24:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:01 INFO - 'cmd': ('bash', 09:24:01 INFO - '-c', 09:24:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:01 INFO - 'enabled': True, 09:24:01 INFO - 'halt_on_failure': False, 09:24:01 INFO - 'name': 'check_screen_resolution'},), 09:24:01 INFO - 'run_cmd_checks_enabled': True, 09:24:01 INFO - 'sps_profile': False, 09:24:01 INFO - 'sps_profile_interval': 0, 09:24:01 INFO - 'suite': 'dromaeojs', 09:24:01 INFO - 'system_bits': '32', 09:24:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:01 INFO - 'title': 't-yosemite-r7-0144', 09:24:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:01 INFO - 'use_talos_json': True, 09:24:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:01 INFO - 'work_dir': 'build'} 09:24:01 INFO - [mozharness: 2016-08-22 16:24:01.366775Z] Running clobber step. 09:24:01 INFO - Running pre-action listener: _resource_record_pre_action 09:24:01 INFO - Running main action method: clobber 09:24:01 INFO - rmtree: /builds/slave/test/build 09:24:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:02 INFO - Running post-action listener: _resource_record_post_action 09:24:02 INFO - [mozharness: 2016-08-22 16:24:02.338684Z] Finished clobber step (success) 09:24:02 INFO - [mozharness: 2016-08-22 16:24:02.338878Z] Running read-buildbot-config step. 09:24:02 INFO - Running pre-action listener: _resource_record_pre_action 09:24:02 INFO - Running main action method: read_buildbot_config 09:24:02 INFO - Using buildbot properties: 09:24:02 INFO - { 09:24:02 INFO - "project": "", 09:24:02 INFO - "product": "firefox", 09:24:02 INFO - "script_repo_revision": "production", 09:24:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:24:02 INFO - "repository": "", 09:24:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:24:02 INFO - "buildid": "20160822064220", 09:24:02 INFO - "pgo_build": "False", 09:24:02 INFO - "basedir": "/builds/slave/test", 09:24:02 INFO - "buildnumber": 96, 09:24:02 INFO - "slavename": "t-yosemite-r7-0144", 09:24:02 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:24:02 INFO - "platform": "yosemite_r7", 09:24:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:24:02 INFO - "branch": "fx-team", 09:24:02 INFO - "repo_path": "integration/fx-team", 09:24:02 INFO - "revision": "194fe275b4e60ded2af6b25173eec421f0dba8ad", 09:24:02 INFO - "stage_platform": "macosx64", 09:24:02 INFO - "builduid": "f13a8455ecd24782bc55d6436cef10f3", 09:24:02 INFO - "slavebuilddir": "test" 09:24:02 INFO - } 09:24:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:24:02 INFO - Running post-action listener: _resource_record_post_action 09:24:02 INFO - [mozharness: 2016-08-22 16:24:02.345176Z] Finished read-buildbot-config step (success) 09:24:02 INFO - [mozharness: 2016-08-22 16:24:02.345386Z] Running download-and-extract step. 09:24:02 INFO - Running pre-action listener: _resource_record_pre_action 09:24:02 INFO - Running main action method: download_and_extract 09:24:02 INFO - mkdir: /builds/slave/test/build/tests 09:24:02 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')]} 09:24:02 INFO - trying https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:24:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:03 INFO - Downloaded 1199 bytes. 09:24:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:24:03 INFO - Using the following test package requirements: 09:24:03 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:24:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:24:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:24:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'jsshell-mac.zip'], 09:24:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:24:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:24:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:24:03 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:24:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:24:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:24:03 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:24:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:24:03 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')]} 09:24:03 INFO - trying https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:24:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:04 INFO - Downloaded 16352497 bytes. 09:24:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:24:11 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 09:24:11 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')]} 09:24:11 INFO - trying https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:24:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:12 INFO - Downloaded 16352497 bytes. 09:24:12 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:24:19 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')]} 09:24:19 INFO - trying https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:24:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:20 INFO - Downloaded 14413981 bytes. 09:24:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 09:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:20 INFO - trying https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:24:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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 09:24:23 INFO - Downloaded 111512483 bytes. 09:24:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:24:23 INFO - mkdir: /builds/slave/test/properties 09:24:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:23 INFO - Contents: 09:24:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:24:24 INFO - Running post-action listener: _resource_record_post_action 09:24:24 INFO - Running post-action listener: set_extra_try_arguments 09:24:24 INFO - [mozharness: 2016-08-22 16:24:24.382739Z] Finished download-and-extract step (success) 09:24:24 INFO - [mozharness: 2016-08-22 16:24:24.382837Z] Running populate-webroot step. 09:24:24 INFO - Running pre-action listener: _resource_record_pre_action 09:24:24 INFO - Running main action method: populate_webroot 09:24:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:24 INFO - '--tppagecycles', 09:24:24 INFO - '7'], 09:24:24 INFO - 'tests': ['tsvgm']}}, 09:24:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['damp', 'tps']}, 09:24:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'tests': ['damp', 'tps']}, 09:24:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['dromaeo_dom']}, 09:24:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['basic_compositor_video']}, 09:24:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['a11yr', 09:24:24 INFO - 'ts_paint', 09:24:24 INFO - 'tpaint', 09:24:24 INFO - 'sessionrestore', 09:24:24 INFO - 'sessionrestore_no_auto_restore', 09:24:24 INFO - 'tabpaint']}, 09:24:24 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:24 INFO - 'ts_paint', 09:24:24 INFO - 'tpaint', 09:24:24 INFO - 'sessionrestore', 09:24:24 INFO - 'sessionrestore_no_auto_restore', 09:24:24 INFO - 'tabpaint']}, 09:24:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:24 INFO - 'ts_paint', 09:24:24 INFO - 'tpaint', 09:24:24 INFO - 'sessionrestore', 09:24:24 INFO - 'sessionrestore_no_auto_restore', 09:24:24 INFO - 'tabpaint']}, 09:24:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:24 INFO - 'ts_paint', 09:24:24 INFO - 'tpaint', 09:24:24 INFO - 'sessionrestore', 09:24:24 INFO - 'sessionrestore_no_auto_restore', 09:24:24 INFO - 'tabpaint']}, 09:24:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['a11yr', 09:24:24 INFO - 'ts_paint', 09:24:24 INFO - 'tpaint', 09:24:24 INFO - 'sessionrestore', 09:24:24 INFO - 'sessionrestore_no_auto_restore', 09:24:24 INFO - 'tabpaint']}, 09:24:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['a11yr', 09:24:24 INFO - 'ts_paint', 09:24:24 INFO - 'tpaint', 09:24:24 INFO - 'sessionrestore', 09:24:24 INFO - 'sessionrestore_no_auto_restore', 09:24:24 INFO - 'tabpaint']}, 09:24:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['tsvgx', 09:24:24 INFO - 'tsvgr_opacity', 09:24:24 INFO - 'tart', 09:24:24 INFO - 'tscrollx', 09:24:24 INFO - 'cart']}, 09:24:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:24 INFO - 'tsvgr_opacity', 09:24:24 INFO - 'tart', 09:24:24 INFO - 'tscrollx', 09:24:24 INFO - 'cart']}, 09:24:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'talos_options': ['--disable-e10s'], 09:24:24 INFO - 'tests': ['tp5o']}, 09:24:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'tests': ['tp5o']}, 09:24:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'talos_options': ['--disable-e10s', 09:24:24 INFO - '--xperf_path', 09:24:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:24 INFO - 'tests': ['tp5n']}, 09:24:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:24 INFO - 'talos_options': ['--xperf_path', 09:24:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:24 INFO - 'tests': ['tp5n']}}, 09:24:24 INFO - 'talos.zip': {'path': '', 09:24:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:24 INFO - Running post-action listener: _resource_record_post_action 09:24:24 INFO - [mozharness: 2016-08-22 16:24:24.401206Z] Finished populate-webroot step (success) 09:24:24 INFO - [mozharness: 2016-08-22 16:24:24.401338Z] Running create-virtualenv step. 09:24:24 INFO - Running pre-action listener: _resource_record_pre_action 09:24:24 INFO - Running main action method: create_virtualenv 09:24:24 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:24 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 09:24:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:24 INFO - Using real prefix '/tools/python27' 09:24:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:28 INFO - Installing pip.................done. 09:24:28 INFO - Return code: 0 09:24:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:28 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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:28 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 09:24:28 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 09:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:28 INFO - 'HOME': '/Users/cltbld', 09:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:28 INFO - 'LOGNAME': 'cltbld', 09:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:28 INFO - 'MOZ_NO_REMOTE': '1', 09:24:28 INFO - 'NO_EM_RESTART': '1', 09:24:28 INFO - 'PAGER': '/bin/cat', 09:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:28 INFO - 'PWD': '/builds/slave/test', 09:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:28 INFO - 'SHELL': '/bin/bash', 09:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:28 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:28 INFO - 'USER': 'cltbld', 09:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:28 INFO - 'XPC_FLAGS': '0x0', 09:24:28 INFO - 'XPC_SERVICE_NAME': '0', 09:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:28 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 09:24:28 INFO - Cleaning up... 09:24:28 INFO - Return code: 0 09:24:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:28 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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:28 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 09:24:28 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 09:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:28 INFO - 'HOME': '/Users/cltbld', 09:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:28 INFO - 'LOGNAME': 'cltbld', 09:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:28 INFO - 'MOZ_NO_REMOTE': '1', 09:24:28 INFO - 'NO_EM_RESTART': '1', 09:24:28 INFO - 'PAGER': '/bin/cat', 09:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:28 INFO - 'PWD': '/builds/slave/test', 09:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:28 INFO - 'SHELL': '/bin/bash', 09:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:28 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:28 INFO - 'USER': 'cltbld', 09:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:28 INFO - 'XPC_FLAGS': '0x0', 09:24:28 INFO - 'XPC_SERVICE_NAME': '0', 09:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:28 INFO - Downloading/unpacking psutil>=3.1.1 09:24:28 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 09:24:28 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 09:24:28 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 09:24:28 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 09:24:28 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 09:24:28 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 09:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:31 INFO - Installing collected packages: psutil 09:24:31 INFO - Running setup.py install for psutil 09:24:31 INFO - building 'psutil._psutil_osx' extension 09:24:31 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 09:24:31 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 09:24:32 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 09:24:32 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 09:24:32 INFO - building 'psutil._psutil_posix' extension 09:24:32 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 09:24:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:32 INFO - ^ 09:24:32 INFO - 1 warning generated. 09:24:32 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 09:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:32 INFO - Successfully installed psutil 09:24:32 INFO - Cleaning up... 09:24:32 INFO - Return code: 0 09:24:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:24: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 mozsystemmonitor==0.3 09:24:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:32 INFO - 'HOME': '/Users/cltbld', 09:24:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:32 INFO - 'LOGNAME': 'cltbld', 09:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:32 INFO - 'MOZ_NO_REMOTE': '1', 09:24:32 INFO - 'NO_EM_RESTART': '1', 09:24:32 INFO - 'PAGER': '/bin/cat', 09:24:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:32 INFO - 'PWD': '/builds/slave/test', 09:24:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:32 INFO - 'SHELL': '/bin/bash', 09:24:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:32 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:32 INFO - 'USER': 'cltbld', 09:24:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:32 INFO - 'XPC_FLAGS': '0x0', 09:24:32 INFO - 'XPC_SERVICE_NAME': '0', 09:24:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:24:35 INFO - Installing collected packages: mozsystemmonitor 09:24:35 INFO - Running setup.py install for mozsystemmonitor 09:24:35 INFO - Successfully installed mozsystemmonitor 09:24:35 INFO - Cleaning up... 09:24:35 INFO - Return code: 0 09:24:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:35 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 09:24:35 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 09:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:35 INFO - 'HOME': '/Users/cltbld', 09:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:35 INFO - 'LOGNAME': 'cltbld', 09:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:35 INFO - 'MOZ_NO_REMOTE': '1', 09:24:35 INFO - 'NO_EM_RESTART': '1', 09:24:35 INFO - 'PAGER': '/bin/cat', 09:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:35 INFO - 'PWD': '/builds/slave/test', 09:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:35 INFO - 'SHELL': '/bin/bash', 09:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:35 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:35 INFO - 'USER': 'cltbld', 09:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:35 INFO - 'XPC_FLAGS': '0x0', 09:24:35 INFO - 'XPC_SERVICE_NAME': '0', 09:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:35 INFO - Downloading/unpacking jsonschema==2.5.1 09:24:35 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 09:24:35 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 09:24:35 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 09:24:35 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 09:24:35 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 09:24:35 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 09:24:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:38 INFO - warning: no files found matching '*.txt' 09:24:38 INFO - no previously-included directories found matching 'build' 09:24:38 INFO - no previously-included directories found matching 'dist' 09:24:38 INFO - no previously-included directories found matching '.git*' 09:24:38 INFO - Installing collected packages: jsonschema, functools32 09:24:38 INFO - Running setup.py install for functools32 09:24:38 INFO - warning: no files found matching '*.txt' 09:24:38 INFO - no previously-included directories found matching 'build' 09:24:38 INFO - no previously-included directories found matching 'dist' 09:24:38 INFO - no previously-included directories found matching '.git*' 09:24:38 INFO - Successfully installed jsonschema functools32 09:24:38 INFO - Cleaning up... 09:24:38 INFO - Return code: 0 09:24:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:38 INFO - 'HOME': '/Users/cltbld', 09:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:38 INFO - 'LOGNAME': 'cltbld', 09:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:38 INFO - 'MOZ_NO_REMOTE': '1', 09:24:38 INFO - 'NO_EM_RESTART': '1', 09:24:38 INFO - 'PAGER': '/bin/cat', 09:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:38 INFO - 'PWD': '/builds/slave/test', 09:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:38 INFO - 'SHELL': '/bin/bash', 09:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:38 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:38 INFO - 'USER': 'cltbld', 09:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:38 INFO - 'XPC_FLAGS': '0x0', 09:24:38 INFO - 'XPC_SERVICE_NAME': '0', 09:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:24:39 INFO - Cleaning up... 09:24:39 INFO - Return code: 0 09:24:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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', '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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24: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 blobuploader==1.2.4 09:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:39 INFO - 'HOME': '/Users/cltbld', 09:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:39 INFO - 'LOGNAME': 'cltbld', 09:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:39 INFO - 'MOZ_NO_REMOTE': '1', 09:24:39 INFO - 'NO_EM_RESTART': '1', 09:24:39 INFO - 'PAGER': '/bin/cat', 09:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:39 INFO - 'PWD': '/builds/slave/test', 09:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:39 INFO - 'SHELL': '/bin/bash', 09:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:39 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:39 INFO - 'USER': 'cltbld', 09:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:39 INFO - 'XPC_FLAGS': '0x0', 09:24:39 INFO - 'XPC_SERVICE_NAME': '0', 09:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:39 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:43 INFO - Downloading docopt-0.6.1.tar.gz 09:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:43 INFO - Running setup.py install for blobuploader 09:24:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:43 INFO - Running setup.py install for requests 09:24:43 INFO - Running setup.py install for docopt 09:24:43 INFO - Successfully installed blobuploader requests docopt 09:24:43 INFO - Cleaning up... 09:24:44 INFO - Return code: 0 09:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:44 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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:44 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 09:24:44 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 09:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:44 INFO - 'HOME': '/Users/cltbld', 09:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:44 INFO - 'LOGNAME': 'cltbld', 09:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:44 INFO - 'MOZ_NO_REMOTE': '1', 09:24:44 INFO - 'NO_EM_RESTART': '1', 09:24:44 INFO - 'PAGER': '/bin/cat', 09:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:44 INFO - 'PWD': '/builds/slave/test', 09:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:44 INFO - 'SHELL': '/bin/bash', 09:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:44 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:44 INFO - 'USER': 'cltbld', 09:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:44 INFO - 'XPC_FLAGS': '0x0', 09:24:44 INFO - 'XPC_SERVICE_NAME': '0', 09:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-d1caUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-X0Tx1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-HqV2Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-NdYAO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-WGHzab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ihVBJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-e63vQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-1ySFP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-htZDSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-kcsdAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Jq02ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-q5KkCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-NVqR7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Y6Amga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-srZwgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-moRcNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-1hZtD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:46 INFO - Running setup.py install for manifestparser 09:24:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Running setup.py install for mozcrash 09:24:46 INFO - Running setup.py install for mozdebug 09:24:46 INFO - Running setup.py install for mozdevice 09:24:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Running setup.py install for mozfile 09:24:46 INFO - Running setup.py install for mozhttpd 09:24:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Running setup.py install for mozinfo 09:24:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:47 INFO - Running setup.py install for mozInstall 09:24:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:47 INFO - Running setup.py install for mozleak 09:24:47 INFO - Running setup.py install for mozlog 09:24:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:47 INFO - Running setup.py install for moznetwork 09:24:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:47 INFO - Running setup.py install for mozprocess 09:24:47 INFO - Running setup.py install for mozprofile 09:24:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:48 INFO - Running setup.py install for mozrunner 09:24:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:48 INFO - Running setup.py install for mozscreenshot 09:24:48 INFO - Running setup.py install for moztest 09:24:48 INFO - Running setup.py install for mozversion 09:24:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:48 INFO - Cleaning up... 09:24:48 INFO - Return code: 0 09:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:48 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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:48 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 09:24:48 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 09:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:48 INFO - 'HOME': '/Users/cltbld', 09:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:48 INFO - 'LOGNAME': 'cltbld', 09:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:48 INFO - 'MOZ_NO_REMOTE': '1', 09:24:48 INFO - 'NO_EM_RESTART': '1', 09:24:48 INFO - 'PAGER': '/bin/cat', 09:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:48 INFO - 'PWD': '/builds/slave/test', 09:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:48 INFO - 'SHELL': '/bin/bash', 09:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:48 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:48 INFO - 'USER': 'cltbld', 09:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:48 INFO - 'XPC_FLAGS': '0x0', 09:24:48 INFO - 'XPC_SERVICE_NAME': '0', 09:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:48 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-upBAGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-hSaSrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-FRlN5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-29N_Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-7RYxXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-OWAUJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-XyvRq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Q1MmXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-jV_9WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-NFcu5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:49 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)) 09:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:49 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-D_IzUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:50 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)) 09:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:50 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-SeCIb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:50 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)) 09:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:50 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-qn76Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:50 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)) 09:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:50 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-KcyDt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:50 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)) 09:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:50 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-j33_89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:50 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)) 09:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:50 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-qWdouJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:50 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)) 09:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:50 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-bCneLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:50 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)) 09:24:50 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)) 09:24:50 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)) 09:24:50 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)) 09:24:50 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)) 09:24:50 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)) 09:24:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:50 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 09:24:50 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 09:24:50 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 09:24:50 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 09:24:50 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 09:24:50 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 09:24:53 INFO - Downloading blessings-1.6.tar.gz 09:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:53 INFO - Installing collected packages: blessings 09:24:53 INFO - Running setup.py install for blessings 09:24:53 INFO - Successfully installed blessings 09:24:53 INFO - Cleaning up... 09:24:53 INFO - Return code: 0 09:24:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:53 INFO - Reading from file tmpfile_stdout 09:24:53 INFO - Current package versions: 09:24:53 INFO - blessings == 1.6 09:24:53 INFO - blobuploader == 1.2.4 09:24:53 INFO - docopt == 0.6.1 09:24:53 INFO - functools32 == 3.2.3-2 09:24:53 INFO - jsonschema == 2.5.1 09:24:53 INFO - manifestparser == 1.1 09:24:53 INFO - mozInstall == 1.12 09:24:53 INFO - mozcrash == 0.17 09:24:53 INFO - mozdebug == 0.1 09:24:53 INFO - mozdevice == 0.48 09:24:53 INFO - mozfile == 1.2 09:24:53 INFO - mozhttpd == 0.7 09:24:53 INFO - mozinfo == 0.9 09:24:53 INFO - mozleak == 0.1 09:24:53 INFO - mozlog == 3.3 09:24:53 INFO - moznetwork == 0.27 09:24:53 INFO - mozprocess == 0.23 09:24:53 INFO - mozprofile == 0.28 09:24:53 INFO - mozrunner == 6.12 09:24:53 INFO - mozscreenshot == 0.1 09:24:53 INFO - mozsystemmonitor == 0.3 09:24:53 INFO - moztest == 0.7 09:24:53 INFO - mozversion == 1.4 09:24:53 INFO - psutil == 3.1.1 09:24:53 INFO - requests == 1.2.3 09:24:53 INFO - wsgiref == 0.1.2 09:24:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:53 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')]} 09:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 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')]} 09:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:53 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 09:24:53 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 09:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:53 INFO - 'HOME': '/Users/cltbld', 09:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:53 INFO - 'LOGNAME': 'cltbld', 09:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:53 INFO - 'MOZ_NO_REMOTE': '1', 09:24:53 INFO - 'NO_EM_RESTART': '1', 09:24:53 INFO - 'PAGER': '/bin/cat', 09:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:53 INFO - 'PWD': '/builds/slave/test', 09:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:53 INFO - 'SHELL': '/bin/bash', 09:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:53 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:53 INFO - 'USER': 'cltbld', 09:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:53 INFO - 'XPC_FLAGS': '0x0', 09:24:53 INFO - 'XPC_SERVICE_NAME': '0', 09:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 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)) 09:24:54 INFO - Cleaning up... 09:24:54 INFO - Return code: 0 09:24:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:54 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 0x106541a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce395c3cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, '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.ogvqUt0G09/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.sNmigzm8zh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:54 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 09:24:54 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 09:24:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:24:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:54 INFO - 'HOME': '/Users/cltbld', 09:24:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:54 INFO - 'LOGNAME': 'cltbld', 09:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:54 INFO - 'MOZ_NO_REMOTE': '1', 09:24:54 INFO - 'NO_EM_RESTART': '1', 09:24:54 INFO - 'PAGER': '/bin/cat', 09:24:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:54 INFO - 'PWD': '/builds/slave/test', 09:24:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:54 INFO - 'SHELL': '/bin/bash', 09:24:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:24:54 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:54 INFO - 'USER': 'cltbld', 09:24:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:54 INFO - 'XPC_FLAGS': '0x0', 09:24:54 INFO - 'XPC_SERVICE_NAME': '0', 09:24:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:54 INFO - Cleaning up... 09:24:54 INFO - Return code: 0 09:24:54 INFO - Running post-action listener: _resource_record_post_action 09:24:54 INFO - Running post-action listener: _start_resource_monitoring 09:24:54 INFO - Starting resource monitoring. 09:24:54 INFO - [mozharness: 2016-08-22 16:24:54.430497Z] Finished create-virtualenv step (success) 09:24:54 INFO - [mozharness: 2016-08-22 16:24:54.431478Z] Running install step. 09:24:54 INFO - Running pre-action listener: _resource_record_pre_action 09:24:54 INFO - Running main action method: install 09:24:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:54 INFO - Reading from file tmpfile_stdout 09:24:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:54 INFO - Reading from file tmpfile_stdout 09:24:54 INFO - Output received: 09:24:54 INFO - Usage: mozinstall [options] installer 09:24:54 INFO - Options: 09:24:54 INFO - -h, --help show this help message and exit 09:24:54 INFO - -d DEST, --destination=DEST 09:24:54 INFO - Directory to install application into. [default: 09:24:54 INFO - "/builds/slave/test"] 09:24:54 INFO - --app=APP Application being installed. [default: firefox] 09:24:54 INFO - mkdir: /builds/slave/test/build/application 09:24:54 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'] 09:24:54 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 09:25:28 INFO - Reading from file tmpfile_stdout 09:25:28 INFO - Output received: 09:25:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:25:28 INFO - Running post-action listener: _resource_record_post_action 09:25:28 INFO - [mozharness: 2016-08-22 16:25:28.916016Z] Finished install step (success) 09:25:28 INFO - [mozharness: 2016-08-22 16:25:28.916145Z] Running run-tests step. 09:25:28 INFO - Running pre-action listener: _resource_record_pre_action 09:25:28 INFO - Running main action method: run_tests 09:25:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:28 INFO - 2016-08-22 09:25:28.930 screenresolution[2000:15467] starting screenresolution argv=screenresolution get 09:25:28 INFO - 2016-08-22 09:25:28.933 screenresolution[2000:15467] Display 0: 1600x1200x32@60 09:25:28 INFO - 2016-08-22 09:25:28.939 screenresolution[2001:15469] starting screenresolution argv=screenresolution list 09:25:28 INFO - Available Modes on Display 0 09:25:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:29 INFO - Intel Iris: 09:25:29 INFO - Chipset Model: Intel Iris 09:25:29 INFO - Type: GPU 09:25:29 INFO - Bus: Built-In 09:25:29 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:29 INFO - Vendor: Intel (0x8086) 09:25:29 INFO - Device ID: 0x0a2e 09:25:29 INFO - Revision ID: 0x0009 09:25:29 INFO - Displays: 09:25:29 INFO - Display: 09:25:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:29 INFO - Display Serial Number: 1600x1200 60 09:25:29 INFO - Main Display: Yes 09:25:29 INFO - Mirror: Off 09:25:29 INFO - Online: Yes 09:25:29 INFO - Rotation: Supported 09:25:29 INFO - Return code: 0 09:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:29 INFO - Python 2.7.3 09:25:29 INFO - Return code: 0 09:25:29 INFO - grabbing minidump binary from tooltool 09:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:29 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 0x1064a5d30>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10649db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:29 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 09:25:29 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 09:25:29 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 09:25:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:29 INFO - Return code: 0 09:25:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:29 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/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 09:25:29 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/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --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 09:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ogvqUt0G09/Render', 09:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:29 INFO - 'HOME': '/Users/cltbld', 09:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:29 INFO - 'LOGNAME': 'cltbld', 09:25:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:29 INFO - 'MOZ_NO_REMOTE': '1', 09:25:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:29 INFO - 'NO_EM_RESTART': '1', 09:25:29 INFO - 'PAGER': '/bin/cat', 09:25:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:29 INFO - 'PWD': '/builds/slave/test', 09:25:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:29 INFO - 'SHELL': '/bin/bash', 09:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNmigzm8zh/Listeners', 09:25:29 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:29 INFO - 'USER': 'cltbld', 09:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:29 INFO - 'XPC_FLAGS': '0x0', 09:25:29 INFO - 'XPC_SERVICE_NAME': '0', 09:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:29 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/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 09:25:29 INFO - mozversion application_buildid: 20160822064220 09:25:29 INFO - mozversion application_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 09:25:29 INFO - mozversion application_display_name: Nightly 09:25:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:29 INFO - mozversion application_name: Firefox 09:25:29 INFO - mozversion application_remotingname: firefox 09:25:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:25:29 INFO - mozversion application_vendor: Mozilla 09:25:29 INFO - mozversion application_version: 51.0a1 09:25:29 INFO - mozversion platform_buildid: 20160822064220 09:25:29 INFO - mozversion platform_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 09:25:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:25:29 INFO - mozversion platform_version: 51.0a1 09:25:29 INFO - using testdate: 1471883129 09:25:29 INFO - actual date: 1471883129 09:25:29 INFO - starting webserver on 'localhost:51283' 09:25:29 INFO - SUITE-START | Running 2 tests 09:25:29 INFO - TEST-START | dromaeo_css 09:25:29 INFO - operating with platform_type : mac_ 09:25:29 INFO - Initialising browser for dromaeo_css test... 09:25:29 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp9q0irl/profile http://localhost:51283/getInfo.html) 09:25:31 INFO - PROCESS | 2011 | __metrics Screen width/height:1600/1200 09:25:31 INFO - PROCESS | 2011 | colorDepth:24 09:25:31 INFO - PROCESS | 2011 | Browser inner width/height: 1024/689 09:25:31 INFO - PROCESS | 2011 | __metrics 09:25:32 INFO - PROCESS | 2011 | 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" 09:25:32 INFO - PROCESS | 2011 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:32 INFO - TEST-INFO | 2011: exit 0 09:25:32 INFO - Browser initialized. 09:25:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:32 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp9q0irl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:44 INFO - PROCESS | 2013 | RSS: Main: 228761600 09:25:44 INFO - PROCESS | 2013 | 09:26:36 INFO - PROCESS | 2013 | 1471883196297 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] 09:28:47 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51283/tests/dromaeo/cssquery-ext.html) 09:28:48 INFO - PROCESS | 2013 | RSS: Main: 326746112 09:28:48 INFO - PROCESS | 2013 | 09:31:51 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51283/tests/dromaeo/cssquery-ext.html (next: http://localhost:51283/tests/dromaeo/cssquery-jquery.html) 09:31:52 INFO - PROCESS | 2013 | RSS: Main: 371339264 09:31:52 INFO - PROCESS | 2013 | 09:34:54 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51283/tests/dromaeo/cssquery-mootools.html) 09:34:55 INFO - PROCESS | 2013 | RSS: Main: 348672000 09:34:55 INFO - PROCESS | 2013 | 09:37:57 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51283/tests/dromaeo/cssquery-prototype.html) 09:37:58 INFO - PROCESS | 2013 | RSS: Main: 345206784 09:37:58 INFO - PROCESS | 2013 | 09:41:02 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51283/tests/dromaeo/cssquery-yui.html) 09:41:02 INFO - PROCESS | 2013 | RSS: Main: 337526784 09:41:02 INFO - PROCESS | 2013 | 09:44:05 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51283/tests/dromaeo/cssquery-yui.html (next: http://localhost:51283/tests/dromaeo/cssquery-dojo.html) 09:44:06 INFO - PROCESS | 2013 | RSS: Main: 513437696 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | __start_tp_report 09:44:06 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 09:44:06 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 09:44:06 INFO - PROCESS | 2013 | |i|pagename|runs| 09:44:06 INFO - PROCESS | 2013 | |0;dojo.html;3312.5362449257095;3316.2704205074883;3342.9665703342966;3344.08037789608;3361.705743288833;5509.504144626982;5639.15412688097;5663.518600918922;5709.4576015278535;5712.086066229404;5623.212750214963;5628.971855140729;5650.5479561635075;5701.6864072476;5759.884802303962;5114.181730923053;5164.819231326905;5167.7932882684645;5177.534021938025;5238.161894096946;5310.787568497255;5311.521963023347;5328.520433161015;5343.7328133593355;5349.09065458871;5082.567981721558;5252.264682944391;5253.238280449314;5271.28837606922;5273.472652734734;5142.845714628567;5182.144946083891;5190.377154741455;5191.32512773337;5192.350956130484;5052.267421223939;5068.290439338495;5161.690298582097;5180.585553155738;5185.585153187736;5601.103823388238;5607.663540187561;5674.687892165929;5696.943030569724;5717.914231286534;6026.879462410771;6203.131561581382;6213.658248796314;6217.067439884054;6229.127922090911;5119.974400128012;6183.598066125733;6249.7187626556915;6249.999999999978;6319.3680631936895;4920.507949205123;5794.826155215308;5795;5801.245838041028;5803.419658034247;6126.816195514141;6261.217347831521;6297.307296197415;6313.715882785285;6314.652694101868;6062.120992456069;6131.478824299985;6138.324784273726;6138.570300078952;6147.477464415575;6246.281677607133;6255.812325630239;6259;6261.874762504815;6269.310375858652;5989.460948514655;6088.330283668793;6157.907631385533;6170.722317495633;6194.876102478015;5113.284140220372;6190.442860142609;6228.314885362606;6259.561830671901;6263.404976527223;4933.087378834927;4933.58064564516;4936.333594964705;4937;4945.826896058621;4334.869953901388;4407.030453300269;4410.757408342508;4432.202203603318;4433.024734558457;5587.329520457572;5650.491455769001;5660.943390566042;5693.572982026365;5713.857153571194;6268.717907694165;6301.275353334425;6307.148534947723;6307.810765677037;6314.526410519229;5405.108157154104;5609.411011843779;5710.2862142232225;5716.799912003143;5724.971375143097;5383.623146379716;5412.07994640912;5413.458654134555;5432.375276843135;5436.700981446058;5328.094223981855;6246.094316324198;6295.307516173309;6300.653464059521;6302.338254483305;6048.6975651218145;6171.290301615371;6258.405451482284;6282.780102696383;6292.402221788922;6282.340354262737;6295.937040629535;6296.590721603081;6298.464630506458;6318.399752023551;6113.786017489367;6141.986572215535;6158.599691020069;6181.721822518088;6194.690265486617;5893.823185304448;6065.120557519223;6088.847778805565;6229.283632382334;6248.875022499616;5786.132080188006;5788.016037273589;5810.1575271586225;5811.79658711943;5824.796132135355;5771.711414429178;5825.097109947965;5829.15477255804;5846.795362162304;5852.619579727304;4905.411350637946;5688.345840228427;5688.943110568841;5707.343655479507;5708.80019199326;5958.702064896651;6033.396660333931;6046.0930860369535;6107.358727333566;6114.5414093942245;4927.531884470969;5897.557683173865;5908.881822363614;5919.763209471573;5931.110333450017 09:44:06 INFO - PROCESS | 2013 | |1;ext.html;483.2340739927215;502.7008929686835;521.5801279969626;529.872830520675;559.7760895641741;31195.064148075537;31301.686983130163;40280.59719402805;41313;41335.17329653405;42649.14701705964;43161.920951976215;43177.920551986215;43212.703618891406;43240.81110266772;9652.75868103296;9844.556994935245;9866.408015519057;9869.407835529892;9872.407655540655;8797.07630698777;9012.098790121001;9714;11898.64304070875;12166.878331216707;12181.20822146562;12234.632961011139;12235.63293101204;12259.080568957319;12264.448099835485;12019.879801202007;12167.878321216851;12205.572804951784;12225.755484890342;12230.9603683687;11899.524019039229;11977.281363118242;11985.700357491045;11988.580399686056;11999.640010799603;40414.59585404167;40712;40741;40767.59232407697;40918.79540602308;3421.26442814796;3477.1307173206696;3490.2321489272317;3506.281212351462;3619.9276014479565;31257.8437107813;32604.6739532604;32698.836505817555;32701.50947735786;32701.67298327034;3291.2265617580088;3302.290007648367;3303.355845610107;3338.565986421774;3445.8277086145595;503527;507380;508010;508454;511211;60461.39538604557;60641.696791516646;60758.39241607616;60807.39192608106;60892.39107608956;64109.717805644555;64236;64254.357456424834;64303.35696643067;64321.67839160868;16194.67610647804;16497.927634703705;16506.009639421674;16516;16545.66908661844;11519.48162332697;12695.746085078432;12807.167534110253;12820.80768788469;12824.551140710031;14823.70352592942;15289.15909624959;15302.540923772305;15312;15335.616609584626;5583.302087239095;6970.268121847234;7074.823129421806;7211.990321355014;7372.373348265351;842.2882664148784;927.6428574998539;945.6926498887889;956.3544607389983;995.2436148527026;25532.361690957874;25783.355416114748;28103;29176.854115729286;30063.549046764318;872.5157537566585;977.3207620703542;1035.2701345551368;1074.3285446595878;1111.7832022755647;14809.481668141563;14931.552053438414;15492.845071549365;15544.844551554566;16000.439984600484;671650;723570;725060;725790;931257;50752.238716419284;51798.1870634526;51968.480315196364;54842.451575484534;59527.70236148878;1266.6896610330527;1313.5205649937704;1354.6951935814363;1404.1434724817648;1424.6794471243886;29918.846887134358;30852.691473084982;30897.91857284984;31371.21571960628;31565.368692626478;50113.498865010886;50509.49490505195;50607;50638.49361506485;50796.49203507917;556248;557397;559926.0036998215;560393;561141;23285.88357058204;26006.73993260043;26587;26601.66991650371;27246.5913011301;46720.766396167804;46976;47791.522084778706;47878.28182577334;48498.75750621365;38370.80814595909;38644.80677596594;38798.41802373023;39974.20051598894;40254;38087.80956095202;38372.04069898163;38716;39365.80317098396;39966.2006759869;37420;38025.66910158131;38692.80653596714;38699.6130038696;38899.61100389073;31121.68878311188;31122.688773112885;33096.83451582823;33939.66060339365;34198.31603367969;25093.247202583952;25286.49427011486;25316.113936012887;25344.873275633505;25818.354541135872 09:44:06 INFO - PROCESS | 2013 | |2;jquery.html;306.6718611086137;356.65048252712324;375.79894756305384;387.6588602030214;412.1371401266276;15771.369145234192;16820.91589542052;20898.89550552249;20992.8950355248;21037.685854555988;17338.47984560462;20270.69593956092;20721.481962950897;20908.790912090873;20942.89528552355;5362.195670649405;5365.386724631324;5440.619156659035;5537.889242215153;5542.86142846428;5356.9732151339185;5480.150576660604;5481.12302031675;5491.423400542945;5504.64219825712;3901;5257.658252213594;5942.376050514698;5970.820875373745;5998.310194327642;5673.886522269573;5845.327787304472;5939.099488163789;5966.254218222723;5973.283206015284;5724.656520608777;5729.971350143264;5733.197352370671;5734.197212390269;5737.88524229513;12671;15955.840441595552;20241.089150988242;23184.3044708659;23476.530469390687;2309.769023097677;2331.5803155432013;2429.6112621980574;2581.586946088617;2856.985715071432;9872.308938374317;10065.345752526062;10430.322029068086;10523.84214236787;14882.404703811835;1891.498752830501;1894.8199921007483;1920.69268916974;1938.3990962801577;1970.231609672229;121172.78827211703;125148;125320.48077115402;127675.72324276732;128339.35830320882;11366.886331136748;11520.020798232077;11593.76812463746;11599.536018559333;11845.763084738257;14711;14712.264386780618;14716.705665886622;14717.484888028868;14717.705645887023;8338.458000229966;8496.830063398698;8509.319254459628;8557.614907329185;8666.393352465268;8434.831303374021;8439.70461033861;8459.83080338402;8600.655973761104;8615.483071015758;4543.954560454353;4556.88607784808;4557.95442045582;4562.771861406983;4641.559051890133;1846.981530184708;1917.664408728495;1918.6162767446567;1918.7505624269036;1919.7216403621396;873.8863947686888;890.3366991591306;944.9574769135405;959.6353385713384;1029.6910926721953;18224.08879556017;20658.483537911674;21116.78883211179;21218.681719774217;22182.2272215973;882.1311008656468;896.6323807239;935.457434687893;951.5052172870207;952.1620973543376;9315.197138703996;11018.84302148279;11413.402123702688;11460.426978651034;11650.126240531994;527508;531533;533689;552059;556795;98523;123671;124935.37532312462;127522;128429;944.6788092048737;976.7899901521065;1010.5604062232952;1016.8423894296396;1019.7093828258911;15196.392144314546;19805.60388792245;20066.498337541096;20095.799042009392;20134.395968120978;41604.79197603992;52610.736946315024;57093;58976.41023589709;59817.401825982924;76786.23213767791;77597.61201194183;80823;83577.74633380625;84985;7890.605469726376;8044.798880028046;8150.83698326042;8210.220029097227;8454.408191426786;11770.88229117732;12018.819717704417;13075.673108172372;13132.752388523075;13154.934225328812;10829;11182.384968826467;11213.327200368005;11409.771804564029;11606.825897611374;10655.360678359324;11020.944895275472;11024.50389732448;11243.60647377338;11633;10798.892011080103;11162.888371116509;11714.9456548911;11727.882721172678;11742.58900938463;7342.751732205431;7974.043114826258;8209.958950205211;8342.83314333722;8422.368322375969;9000.54997250148;11029.393383363991;11465.082793376676;11489;11491.482883270106 09:44:06 INFO - PROCESS | 2013 | |3;mootools.html;1345.4147445861045;1505.2849896299256;1526.9464069791845;1665.159094657198;1816.8001519832824;7427.962860185698;8230.835383292331;8491.150884911505;8558.529280889548;8593.95703021484;8353.206445387694;8417.074121846592;8418.579071046453;8421.873671894911;8550.657973681045;2337.4273303040736;2371.1108334374608;2374.3114496795906;2375;2384.463495713468;2316.9073237070497;2353.2469609724894;2359.4101474631343;2368.4789346343778;2372.774586414288;2327.6857624220766;2347.835651504395;2356.06935260572;2367.065009321317;2370.5851475991717;2269.3305474884946;2275.3515248154195;2317.5249073939804;2318.9188378406843;2335.8948847301913;2327.1156960355124;2327.93016209514;2336.5677349690363;2338.6608941703357;2341.4146463384154;8432.789180270482;8484.490930544187;8511.446755960842;8564.100769419183;8566.957165214197;5038.722870242135;5251.921221181686;5253.3958594761325;5262.23697563855;5320.361556613192;3391.7625766196375;3535.4696795480627;3607.9639203608153;3615.963840361589;3617.8371973261264;921.1801496667971;931.1852129386787;955.2262667239559;969.9175570076552;972.8589354543551;10816.080633146192;10906.34561926287;10964.56141754337;10971;11001.559937602566;4323.589259020388;4342.956570434255;4516.299973504112;4526.592606665416;4558.27067669178;8711.738647840575;8737.825243495094;8751.649934002697;8806.559672016374;8811.427257228259;5102.311187989574;5107.080725469451;5124.128898087334;5156.845294641167;5159.071367153873;4314.633256173261;4456.665750068758;4633.443986721615;4751.59611433032;4799.472058073609;3616.5298511193378;3678.3378991781738;3752.0057184846037;3764.5482542095124;3796.9050773730323;1113.897241730697;1161.2103769436865;1163.2264544078262;1169.1698893785338;1178.6287319494331;896.4845214001975;904.7738065483629;919.8206349761866;947.4599379557061;967.3132076225818;5442.782288708487;5694.686792226385;5752.511036561939;5781.8554536136935;5818.5345172386105;434.61536540162183;449.07938725612365;467.97513445554125;963.710886733977;1066.2323127348297;3739.85040598373;3938.232044751246;4015.859444919414;4039.7374170678813;4062.3297155969526;9965.501724913725;10328.586856525804;10344.120749736358;10410.219233557362;10425.0096240857;9466.432014079177;9857.802843943224;10011.299209055442;10238.53926573306;10261.230407719451;7598.430117741192;7714.344280736088;7863.174366691415;8047.195280471906;8111.797205069921;5800.187973683772;5851.707414629337;5883.676397797991;5909.231799866162;5992.891315106719;9302;9576.425414475154;9689.515524223902;9703.272254580794;9767.120959113714;9429.245660347018;9493.810123797624;9744.805103898025;9870.555824987749;9985.850212246967;6600.207975043026;6755.729770809309;6772.312752279823;7277.345038946309;7443.54850804088;7669.156392796899;8242.423030387816;8249.175082491704;8257.587120644064;8330.958630171228;7253.673584688596;7273.454490913308;7289.2710728928805;7289.927100728924;7465.925340746523;7100.396466300423;7133.500654954103;7190.101237345332;7193.892091618525;7242.348188663045;6825.897611535732;6835.179778426621;6839.863202736017;6894.069300644549;7017.543859649107;4230.794223646246;4791.8978634914865;4873.220284754422;4877.000214955997;5065.240213967934;4863.3434486343895;4921.926171107365;4968.882001549767;4969.726665033458;5037.345145131256 09:44:06 INFO - PROCESS | 2013 | |4;prototype.html;289.3128819054745;300.8285277391887;306.1656984716646;306.37652377411956;309.498612248158;3895.7272990890647;4371.03303513419;4830.864746784511;5281.524662780349;5330.920036199455;5098.980203959204;5225.6603320784125;5294.285271488348;5304.602154838383;5341.679499230049;3258.8533515991717;3357.875111837537;3374.6287908330187;3575.7675751076226;3800.327855743464;3335.6997870191676;4001.6398524132824;4023.376376661622;4025.5508017113816;4049.2508885856064;3269.9182520436943;3276.9016929492154;3957.861474848381;3985.8604948826796;3997.2405243003736;3531.514975980516;3785.5646600641003;3865.4974853269177;3946.48695669564;3981.7610943343348;2742.3966727319957;3474.1488335357744;3479.982600087009;3489.307685772398;3500.2299494111253;5047.671901326402;5077.2637967494875;5088.516590923857;5108.284840122349;5112.258722485256;4094.897627559335;4243.172581346638;4356.499002614708;4440.937331442158;4495.550444955511;5367.865803354908;5375.704336261504;5413.891722165535;5451.672899626035;5463.7814487420455;3017.7476347315837;3506.474028895686;3553.751237413382;3643.7813731175947;3834.194819087995;4894.021195760862;5434.592405569559;5601.859953501154;5750.6262092963825;5775.740091695884;3356.0466789225325;3816.255830113101;3868.7947869713994;3883.689304855605;3892.6107389260847;3315.8176300303717;3897.824597893102;3954;3955.0337247064704;3958.1094253792667;3701.9074523136596;4474.530174331649;4482.932756008662;4489;4493.865413928358;4540.846139631542;5146.529665760456;5429.914017196497;5439.673619582759;5449.482299181651;1326.8986741005135;1358.130796290375;1361.2921280933858;1361.584716661408;1363.8704323089291;667.6695035957135;804.8752443371287;841.6254766628791;842.7598134531629;843.7890527368158;4286.249906266391;4516.548345165523;4889.046635906036;4924.72913989734;5099.286099946011;5471.50756431923;5474.890502189934;5744.339400968858;5773.566982476331;5784.4504772046585;4146.398772178018;4268.758901576697;5124.692518448905;5203.505666961632;5216.713080780518;2464.3223113643535;2483.540544999181;2638.511875303075;2958.304798372381;3022.7757758108;5777.45114214149;5878.323992740804;5895.587308888336;5901.203337549462;5922.940770592325;5378.462153784591;5793.362730099686;5830.941690583125;5842.750541041644;5851.912221316684;5519.978803921287;5920.2303700519515;5959.5828292020005;5995.650978529796;6013.51891848651;4994.650374473752;5179.870503237449;5564;5726.79956201531;5832.766689332379;4769.73766442849;5199.908019315986;5288.550473209821;5681.488666020078;5780;4913.877153071202;4937.7531123444405;4966.900661986668;5480.917786233289;6003.609765365237;3353.346097510962;3946.8026598670526;3997.6002399760955;4013.317735984948;4032.9596704032583;4776.95223047779;4869.805207791649;5443.7278136092245;5561.304836895388;5685.374608793112;5059.620528460307;5085.084684756779;5446.863828404322;5552.5557955362665;5573.136163894603;4909.386326709161;5345.278387417648;5459.235707000944;5608.523275521463;5608.775648974159;4921.384826896638;4946.802127914843;5447.455254474679;5492.752826122914;5580.414056524007;4281.336392859112;5261;5383.219433182088;5512.779488820403;5555.416681248411;5104.846854594368;5314;5488.38092762644;5537.307836520435;5579.9163012555655 09:44:06 INFO - PROCESS | 2013 | |5;yui.html;689.6310473896465;709.939655129314;763.912150102738;797.4736673795296;805.3034125481461;15889.920550397246;16756.497305080837;16780.160991950415;16800.07599582024;16811.747823782654;14912.254387280647;15056.322465489053;15062.472813451532;15084.924575377136;15092.39630414785;676.6278546799265;700.4956431369405;719.2447929673822;822.3708862720009;845.8477474054667;852.2585350744861;864.2437866866492;867.7223288547667;867.9869801952944;870.503812826689;921.7465197070792;925.9212966897821;927.8608208768671;928.9163975242227;929.0755698080419;640.6092283706935;741.0033504935852;914.3416739947228;915.9404638698463;917.610015743313;659.6932426421737;678.131991051455;678.8235058884676;678.8336857469902;680.4148432348177;14645.92677036608;14668.779968300483;14684.779728304084;14710.632234194123;14723.852761472355;13675.589732307948;13938.790918136236;13944.790828137586;14028.298585070706;14354.210518421483;11309.547618095348;12581.874181258161;12695.524198761008;12750.29873356965;12913.677158071123;4601.976990115061;4632.7220366777765;4672.183132000647;4762.880927976794;4784.808607655689;113692.43153784178;115103;116055.41972290084;117764;118079.99999999914;10749.731256718645;10880.836787448035;10915.399653019002;11040.454336392912;11141.2201145919;20522.897385513275;20794;20808.687869681966;20815.37553873386;20833.791662083186;6647.86704265912;7787.10448298453;8133.0646975598565;8194.836103277901;8517.23344898962;4495.280755079171;4582.495925448198;4592.5407459254475;4619.284010978304;4629.884252893705;3538.4515400113023;3640.12636967126;3706.8887933362043;3724.683401910868;3758.699304055669;626.123427201921;626.123427201921;628.3119983617931;637.4931929116364;655.6164643683499;521.9295395121686;556.9777208911598;586.3784388548153;638.9329819201944;647.5531883000715;9086.636534538544;9369.953150234205;9491.620335186653;9598.42409455435;9608.9039109608;544.3658138268872;569.9145128230798;606.3996643323167;617.7374615788272;699.1575151941897;3871.472268142243;3993.24297309183;4637.865944158325;4690.624750019991;4768.833090841873;89756.6536501953;98710.01289987152;111737.32394014097;143229;149308.253458732;81556;109820;114665;116307;140936.5906340944;79365;99017.99999999856;102316;103514;110599.94000600037;8577;8613.353998450017;9645.807083858424;9682.70951871445;9690.75773105678;54508.454915451926;58970;60054.69972650109;60402.69798650979;60802.391976081446;86838;87162;88120.55939720261;90077.54961225152;90216;12917.483300668244;13457.192568445924;13492.392842322315;13586.660333491742;13912.860871391156;14837.851621484078;14885.702285954438;15005.399784008518;15008.699826003638;15058.623534411727;8562.11633440642;13920.58238252854;13938.790918136034;14437.927810360881;14842.925785371004;14232.71534569282;14420.567382978528;14595.92702036483;14743.336549855068;14784.408623654934;13672.974526910322;13746.875937218994;13755.31223438844;13874.653133671336;14262.928685356506;10549.683509494727;10695.197860160364;11452.427378630868;11534.711632209262;11630.418479076181;10782;11624.88375116238;11799.292042477478;11846.99300559462;11950.940245298718 09:44:06 INFO - PROCESS | 2013 | __end_tp_report 09:44:06 INFO - PROCESS | 2013 | __start_cc_report 09:44:06 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,1437 09:44:06 INFO - PROCESS | 2013 | __end_cc_report 09:44:06 INFO - PROCESS | 2013 | __startTimestamp1471884246147__endTimestamp 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | ------- Summary: start ------- 09:44:06 INFO - PROCESS | 2013 | Number of tests: 6 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | [#0] dojo.html Cycles:165 Average:5669.98 Median:5788.02 stddev:636.32 (11.0%) stddev-sans-first:610.81 09:44:06 INFO - PROCESS | 2013 | Values: 3312.5 3316.3 3343.0 3344.1 3361.7 5509.5 5639.2 5663.5 5709.5 5712.1 5623.2 5629.0 5650.5 5701.7 5759.9 5114.2 5164.8 5167.8 5177.5 5238.2 5310.8 5311.5 5328.5 5343.7 5349.1 5082.6 5252.3 5253.2 5271.3 5273.5 5142.8 5182.1 5190.4 5191.3 5192.4 5052.3 5068.3 5161.7 5180.6 5185.6 5601.1 5607.7 5674.7 5696.9 5717.9 6026.9 6203.1 6213.7 6217.1 6229.1 5120.0 6183.6 6249.7 6250.0 6319.4 4920.5 5794.8 5795.0 5801.2 5803.4 6126.8 6261.2 6297.3 6313.7 6314.7 6062.1 6131.5 6138.3 6138.6 6147.5 6246.3 6255.8 6259.0 6261.9 6269.3 5989.5 6088.3 6157.9 6170.7 6194.9 5113.3 6190.4 6228.3 6259.6 6263.4 4933.1 4933.6 4936.3 4937.0 4945.8 4334.9 4407.0 4410.8 4432.2 4433.0 5587.3 5650.5 5660.9 5693.6 5713.9 6268.7 6301.3 6307.1 6307.8 6314.5 5405.1 5609.4 5710.3 5716.8 5725.0 5383.6 5412.1 5413.5 5432.4 5436.7 5328.1 6246.1 6295.3 6300.7 6302.3 6048.7 6171.3 6258.4 6282.8 6292.4 6282.3 6295.9 6296.6 6298.5 6318.4 6113.8 6142.0 6158.6 6181.7 6194.7 5893.8 6065.1 6088.8 6229.3 6248.9 5786.1 5788.0 5810.2 5811.8 5824.8 5771.7 5825.1 5829.2 5846.8 5852.6 4905.4 5688.3 5688.9 5707.3 5708.8 5958.7 6033.4 6046.1 6107.4 6114.5 4927.5 5897.6 5908.9 5919.8 5931.1 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | [#1] ext.html Cycles:180 Average:73472.63 Median:38371.42 stddev:166006.64 (432.6%) stddev-sans-first:166381.88 09:44:06 INFO - PROCESS | 2013 | Values: 483.2 502.7 521.6 529.9 559.8 31195.1 31301.7 40280.6 41313.0 41335.2 42649.1 43161.9 43177.9 43212.7 43240.8 9652.8 9844.6 9866.4 9869.4 9872.4 8797.1 9012.1 9714.0 11898.6 12166.9 12181.2 12234.6 12235.6 12259.1 12264.4 12019.9 12167.9 12205.6 12225.8 12231.0 11899.5 11977.3 11985.7 11988.6 11999.6 40414.6 40712.0 40741.0 40767.6 40918.8 3421.3 3477.1 3490.2 3506.3 3619.9 31257.8 32604.7 32698.8 32701.5 32701.7 3291.2 3302.3 3303.4 3338.6 3445.8 503527.0 507380.0 508010.0 508454.0 511211.0 60461.4 60641.7 60758.4 60807.4 60892.4 64109.7 64236.0 64254.4 64303.4 64321.7 16194.7 16497.9 16506.0 16516.0 16545.7 11519.5 12695.7 12807.2 12820.8 12824.6 14823.7 15289.2 15302.5 15312.0 15335.6 5583.3 6970.3 7074.8 7212.0 7372.4 842.3 927.6 945.7 956.4 995.2 25532.4 25783.4 28103.0 29176.9 30063.5 872.5 977.3 1035.3 1074.3 1111.8 14809.5 14931.6 15492.8 15544.8 16000.4 671650.0 723570.0 725060.0 725790.0 931257.0 50752.2 51798.2 51968.5 54842.5 59527.7 1266.7 1313.5 1354.7 1404.1 1424.7 29918.8 30852.7 30897.9 31371.2 31565.4 50113.5 50509.5 50607.0 50638.5 50796.5 556248.0 557397.0 559926.0 560393.0 561141.0 23285.9 26006.7 26587.0 26601.7 27246.6 46720.8 46976.0 47791.5 47878.3 48498.8 38370.8 38644.8 38798.4 39974.2 40254.0 38087.8 38372.0 38716.0 39365.8 39966.2 37420.0 38025.7 38692.8 38699.6 38899.6 31121.7 31122.7 33096.8 33939.7 34198.3 25093.2 25286.5 25316.1 25344.9 25818.4 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | [#2] jquery.html Cycles:180 Average:33340.77 Median:12904.06 stddev:90880.15 (704.3%) stddev-sans-first:91101.25 09:44:06 INFO - PROCESS | 2013 | Values: 306.7 356.7 375.8 387.7 412.1 15771.4 16820.9 20898.9 20992.9 21037.7 17338.5 20270.7 20721.5 20908.8 20942.9 5362.2 5365.4 5440.6 5537.9 5542.9 5357.0 5480.2 5481.1 5491.4 5504.6 3901.0 5257.7 5942.4 5970.8 5998.3 5673.9 5845.3 5939.1 5966.3 5973.3 5724.7 5730.0 5733.2 5734.2 5737.9 12671.0 15955.8 20241.1 23184.3 23476.5 2309.8 2331.6 2429.6 2581.6 2857.0 9872.3 10065.3 10430.3 10523.8 14882.4 1891.5 1894.8 1920.7 1938.4 1970.2 121172.8 125148.0 125320.5 127675.7 128339.4 11366.9 11520.0 11593.8 11599.5 11845.8 14711.0 14712.3 14716.7 14717.5 14717.7 8338.5 8496.8 8509.3 8557.6 8666.4 8434.8 8439.7 8459.8 8600.7 8615.5 4544.0 4556.9 4558.0 4562.8 4641.6 1847.0 1917.7 1918.6 1918.8 1919.7 873.9 890.3 945.0 959.6 1029.7 18224.1 20658.5 21116.8 21218.7 22182.2 882.1 896.6 935.5 951.5 952.2 9315.2 11018.8 11413.4 11460.4 11650.1 527508.0 531533.0 533689.0 552059.0 556795.0 98523.0 123671.0 124935.4 127522.0 128429.0 944.7 976.8 1010.6 1016.8 1019.7 15196.4 19805.6 20066.5 20095.8 20134.4 41604.8 52610.7 57093.0 58976.4 59817.4 76786.2 77597.6 80823.0 83577.7 84985.0 7890.6 8044.8 8150.8 8210.2 8454.4 11770.9 12018.8 13075.7 13132.8 13154.9 10829.0 11182.4 11213.3 11409.8 11606.8 10655.4 11020.9 11024.5 11243.6 11633.0 10798.9 11162.9 11714.9 11727.9 11742.6 7342.8 7974.0 8210.0 8342.8 8422.4 9000.5 11029.4 11465.1 11489.0 11491.5 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | [#3] mootools.html Cycles:180 Average:5493.54 Median:5157.96 stddev:3027.43 (58.7%) stddev-sans-first:3019.87 09:44:06 INFO - PROCESS | 2013 | Values: 1345.4 1505.3 1526.9 1665.2 1816.8 7428.0 8230.8 8491.2 8558.5 8594.0 8353.2 8417.1 8418.6 8421.9 8550.7 2337.4 2371.1 2374.3 2375.0 2384.5 2316.9 2353.2 2359.4 2368.5 2372.8 2327.7 2347.8 2356.1 2367.1 2370.6 2269.3 2275.4 2317.5 2318.9 2335.9 2327.1 2327.9 2336.6 2338.7 2341.4 8432.8 8484.5 8511.4 8564.1 8567.0 5038.7 5251.9 5253.4 5262.2 5320.4 3391.8 3535.5 3608.0 3616.0 3617.8 921.2 931.2 955.2 969.9 972.9 10816.1 10906.3 10964.6 10971.0 11001.6 4323.6 4343.0 4516.3 4526.6 4558.3 8711.7 8737.8 8751.6 8806.6 8811.4 5102.3 5107.1 5124.1 5156.8 5159.1 4314.6 4456.7 4633.4 4751.6 4799.5 3616.5 3678.3 3752.0 3764.5 3796.9 1113.9 1161.2 1163.2 1169.2 1178.6 896.5 904.8 919.8 947.5 967.3 5442.8 5694.7 5752.5 5781.9 5818.5 434.6 449.1 468.0 963.7 1066.2 3739.9 3938.2 4015.9 4039.7 4062.3 9965.5 10328.6 10344.1 10410.2 10425.0 9466.4 9857.8 10011.3 10238.5 10261.2 7598.4 7714.3 7863.2 8047.2 8111.8 5800.2 5851.7 5883.7 5909.2 5992.9 9302.0 9576.4 9689.5 9703.3 9767.1 9429.2 9493.8 9744.8 9870.6 9985.9 6600.2 6755.7 6772.3 7277.3 7443.5 7669.2 8242.4 8249.2 8257.6 8331.0 7253.7 7273.5 7289.3 7289.9 7465.9 7100.4 7133.5 7190.1 7193.9 7242.3 6825.9 6835.2 6839.9 6894.1 7017.5 4230.8 4791.9 4873.2 4877.0 5065.2 4863.3 4921.9 4968.9 4969.7 5037.3 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | [#4] prototype.html Cycles:180 Average:4411.54 Median:4980.78 stddev:1392.91 (28.0%) stddev-sans-first:1362.02 09:44:06 INFO - PROCESS | 2013 | Values: 289.3 300.8 306.2 306.4 309.5 3895.7 4371.0 4830.9 5281.5 5330.9 5099.0 5225.7 5294.3 5304.6 5341.7 3258.9 3357.9 3374.6 3575.8 3800.3 3335.7 4001.6 4023.4 4025.6 4049.3 3269.9 3276.9 3957.9 3985.9 3997.2 3531.5 3785.6 3865.5 3946.5 3981.8 2742.4 3474.1 3480.0 3489.3 3500.2 5047.7 5077.3 5088.5 5108.3 5112.3 4094.9 4243.2 4356.5 4440.9 4495.6 5367.9 5375.7 5413.9 5451.7 5463.8 3017.7 3506.5 3553.8 3643.8 3834.2 4894.0 5434.6 5601.9 5750.6 5775.7 3356.0 3816.3 3868.8 3883.7 3892.6 3315.8 3897.8 3954.0 3955.0 3958.1 3701.9 4474.5 4482.9 4489.0 4493.9 4540.8 5146.5 5429.9 5439.7 5449.5 1326.9 1358.1 1361.3 1361.6 1363.9 667.7 804.9 841.6 842.8 843.8 4286.2 4516.5 4889.0 4924.7 5099.3 5471.5 5474.9 5744.3 5773.6 5784.5 4146.4 4268.8 5124.7 5203.5 5216.7 2464.3 2483.5 2638.5 2958.3 3022.8 5777.5 5878.3 5895.6 5901.2 5922.9 5378.5 5793.4 5830.9 5842.8 5851.9 5520.0 5920.2 5959.6 5995.7 6013.5 4994.7 5179.9 5564.0 5726.8 5832.8 4769.7 5199.9 5288.6 5681.5 5780.0 4913.9 4937.8 4966.9 5480.9 6003.6 3353.3 3946.8 3997.6 4013.3 4033.0 4777.0 4869.8 5443.7 5561.3 5685.4 5059.6 5085.1 5446.9 5552.6 5573.1 4909.4 5345.3 5459.2 5608.5 5608.8 4921.4 4946.8 5447.5 5492.8 5580.4 4281.3 5261.0 5383.2 5512.8 5555.4 5104.8 5314.0 5488.4 5537.3 5579.9 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - PROCESS | 2013 | [#5] yui.html Cycles:180 Average:23374.38 Median:4244.26 stddev:35803.04 (843.6%) stddev-sans-first:35862.96 09:44:06 INFO - PROCESS | 2013 | Values: 689.6 709.9 763.9 797.5 805.3 15889.9 16756.5 16780.2 16800.1 16811.7 14912.3 15056.3 15062.5 15084.9 15092.4 676.6 700.5 719.2 822.4 845.8 852.3 864.2 867.7 868.0 870.5 921.7 925.9 927.9 928.9 929.1 640.6 741.0 914.3 915.9 917.6 659.7 678.1 678.8 678.8 680.4 14645.9 14668.8 14684.8 14710.6 14723.9 13675.6 13938.8 13944.8 14028.3 14354.2 11309.5 12581.9 12695.5 12750.3 12913.7 4602.0 4632.7 4672.2 4762.9 4784.8 113692.4 115103.0 116055.4 117764.0 118080.0 10749.7 10880.8 10915.4 11040.5 11141.2 20522.9 20794.0 20808.7 20815.4 20833.8 6647.9 7787.1 8133.1 8194.8 8517.2 4495.3 4582.5 4592.5 4619.3 4629.9 3538.5 3640.1 3706.9 3724.7 3758.7 626.1 626.1 628.3 637.5 655.6 521.9 557.0 586.4 638.9 647.6 9086.6 9370.0 9491.6 9598.4 9608.9 544.4 569.9 606.4 617.7 699.2 3871.5 3993.2 4637.9 4690.6 4768.8 89756.7 98710.0 111737.3 143229.0 149308.3 81556.0 109820.0 114665.0 116307.0 140936.6 79365.0 99018.0 102316.0 103514.0 110599.9 8577.0 8613.4 9645.8 9682.7 9690.8 54508.5 58970.0 60054.7 60402.7 60802.4 86838.0 87162.0 88120.6 90077.5 90216.0 12917.5 13457.2 13492.4 13586.7 13912.9 14837.9 14885.7 15005.4 15008.7 15058.6 8562.1 13920.6 13938.8 14437.9 14842.9 14232.7 14420.6 14595.9 14743.3 14784.4 13673.0 13746.9 13755.3 13874.7 14262.9 10549.7 10695.2 11452.4 11534.7 11630.4 10782.0 11624.9 11799.3 11847.0 11950.9 09:44:06 INFO - PROCESS | 2013 | -------- Summary: end -------- 09:44:06 INFO - PROCESS | 2013 | 09:44:06 INFO - TEST-INFO | 2013: exit 0 09:44:06 INFO - TEST-OK | dromaeo_css | took 1117277ms 09:44:06 INFO - TEST-START | kraken 09:44:06 INFO - operating with platform_type : mac_ 09:44:06 INFO - Initialising browser for kraken test... 09:44:06 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmplCqFVc/profile http://localhost:51283/getInfo.html) 09:44:09 INFO - PROCESS | 2017 | __metrics Screen width/height:1600/1200 09:44:09 INFO - PROCESS | 2017 | colorDepth:24 09:44:09 INFO - PROCESS | 2017 | Browser inner width/height: 1024/689 09:44:09 INFO - PROCESS | 2017 | __metrics 09:44:09 INFO - PROCESS | 2017 | 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" 09:44:09 INFO - PROCESS | 2017 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:09 INFO - TEST-INFO | 2017: exit 0 09:44:09 INFO - Browser initialized. 09:44:09 INFO - Running cycle 1/1 for kraken test... 09:44:09 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmplCqFVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:21 INFO - PROCESS | 2018 | RSS: Main: 228962304 09:44:21 INFO - PROCESS | 2018 | 09:44:24 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51283/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:25 INFO - PROCESS | 2018 | RSS: Main: 294723584 09:44:25 INFO - PROCESS | 2018 | 09:44:27 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51283/tests/kraken/driver.html?testName=audio-dft) 09:44:28 INFO - PROCESS | 2018 | RSS: Main: 294768640 09:44:28 INFO - PROCESS | 2018 | 09:44:32 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51283/tests/kraken/driver.html?testName=audio-fft) 09:44:32 INFO - PROCESS | 2018 | RSS: Main: 380440576 09:44:32 INFO - PROCESS | 2018 | 09:44:34 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51283/tests/kraken/driver.html?testName=audio-oscillator) 09:44:35 INFO - PROCESS | 2018 | RSS: Main: 282578944 09:44:35 INFO - PROCESS | 2018 | 09:44:37 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:38 INFO - PROCESS | 2018 | RSS: Main: 286732288 09:44:38 INFO - PROCESS | 2018 | 09:44:40 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51283/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:41 INFO - PROCESS | 2018 | RSS: Main: 322863104 09:44:41 INFO - PROCESS | 2018 | 09:44:44 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51283/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:45 INFO - PROCESS | 2018 | RSS: Main: 323657728 09:44:45 INFO - PROCESS | 2018 | 09:44:47 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51283/tests/kraken/driver.html?testName=json-parse-financial) 09:44:48 INFO - PROCESS | 2018 | RSS: Main: 323391488 09:44:48 INFO - PROCESS | 2018 | 09:44:50 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:50 INFO - PROCESS | 2018 | RSS: Main: 301182976 09:44:50 INFO - PROCESS | 2018 | 09:44:52 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:53 INFO - PROCESS | 2018 | RSS: Main: 303947776 09:44:53 INFO - PROCESS | 2018 | 09:44:55 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:56 INFO - PROCESS | 2018 | RSS: Main: 306315264 09:44:56 INFO - PROCESS | 2018 | 09:44:59 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:59 INFO - PROCESS | 2018 | RSS: Main: 315596800 09:44:59 INFO - PROCESS | 2018 | 09:45:02 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:03 INFO - PROCESS | 2018 | RSS: Main: 316825600 09:45:03 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:51283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51283/tests/kraken/driver.html?testName=ai-astar) 09:45:05 INFO - PROCESS | 2018 | RSS: Main: 360542208 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | __start_tp_report 09:45:05 INFO - PROCESS | 2018 | _x_x_mozilla_page_load 09:45:05 INFO - PROCESS | 2018 | _x_x_mozilla_page_load_details 09:45:05 INFO - PROCESS | 2018 | |i|pagename|runs| 09:45:05 INFO - PROCESS | 2018 | |0;ai-astar;97;112;106;113;113;113;115;114;112;112 09:45:05 INFO - PROCESS | 2018 | |1;audio-beat-detection;146;108;133;163;109;128;128;106;183;136 09:45:05 INFO - PROCESS | 2018 | |2;audio-dft;179;186;185;202;267;184;179;182;182;183 09:45:05 INFO - PROCESS | 2018 | |3;audio-fft;75;77;123;119;80;61;66;84;89;56 09:45:05 INFO - PROCESS | 2018 | |4;audio-oscillator;83;87;137;70;71;76;119;70;70;123 09:45:05 INFO - PROCESS | 2018 | |5;imaging-gaussian-blur;87;84;86;83;86;83;88;83;88;84 09:45:05 INFO - PROCESS | 2018 | |6;imaging-darkroom;92;92;93;93;92;92;111;152;93;92 09:45:05 INFO - PROCESS | 2018 | |7;imaging-desaturate;84;86;83;84;85;86;85;87;102;132 09:45:05 INFO - PROCESS | 2018 | |8;json-parse-financial;55;56;55;57;54;53;55;54;53;55 09:45:05 INFO - PROCESS | 2018 | |9;json-stringify-tinderbox;65;73;69;71;74;70;69;69;70;69 09:45:05 INFO - PROCESS | 2018 | |10;stanford-crypto-aes;85;85;85;85;87;88;87;90;86;85 09:45:05 INFO - PROCESS | 2018 | |11;stanford-crypto-ccm;149;160;150;157;139;138;135;137;152;142 09:45:05 INFO - PROCESS | 2018 | |12;stanford-crypto-pbkdf2;162;220;235;169;169;167;169;166;167;166 09:45:05 INFO - PROCESS | 2018 | |13;stanford-crypto-sha256-iterative;68;67;69;66;67;67;68;67;65;67 09:45:05 INFO - PROCESS | 2018 | __end_tp_report 09:45:05 INFO - PROCESS | 2018 | __start_cc_report 09:45:05 INFO - PROCESS | 2018 | _x_x_mozilla_cycle_collect,2109 09:45:05 INFO - PROCESS | 2018 | __end_cc_report 09:45:05 INFO - PROCESS | 2018 | __startTimestamp1471884305334__endTimestamp 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | ------- Summary: start ------- 09:45:05 INFO - PROCESS | 2018 | Number of tests: 14 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:5.38 (4.8%) stddev-sans-first:2.54 09:45:05 INFO - PROCESS | 2018 | Values: 97.0 112.0 106.0 113.0 113.0 113.0 115.0 114.0 112.0 112.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:134.50 stddev:24.83 (18.5%) stddev-sans-first:25.95 09:45:05 INFO - PROCESS | 2018 | Values: 146.0 108.0 133.0 163.0 109.0 128.0 128.0 106.0 183.0 136.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#2] audio-dft Cycles:10 Average:192.90 Median:184.50 stddev:26.84 (14.5%) stddev-sans-first:28.00 09:45:05 INFO - PROCESS | 2018 | Values: 179.0 186.0 185.0 202.0 267.0 184.0 179.0 182.0 182.0 183.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:22.47 (29.6%) stddev-sans-first:23.65 09:45:05 INFO - PROCESS | 2018 | Values: 75.0 77.0 123.0 119.0 80.0 61.0 66.0 84.0 89.0 56.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:70.50 stddev:25.71 (36.5%) stddev-sans-first:27.13 09:45:05 INFO - PROCESS | 2018 | Values: 83.0 87.0 137.0 70.0 71.0 76.0 119.0 70.0 70.0 123.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:2.04 (2.4%) stddev-sans-first:2.06 09:45:05 INFO - PROCESS | 2018 | Values: 87.0 84.0 86.0 83.0 86.0 83.0 88.0 83.0 88.0 84.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:92.00 stddev:19.12 (20.8%) stddev-sans-first:20.05 09:45:05 INFO - PROCESS | 2018 | Values: 92.0 92.0 93.0 93.0 92.0 92.0 111.0 152.0 93.0 92.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:85.00 stddev:15.28 (18.0%) stddev-sans-first:15.97 09:45:05 INFO - PROCESS | 2018 | Values: 84.0 86.0 83.0 84.0 85.0 86.0 85.0 87.0 102.0 132.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.32 09:45:05 INFO - PROCESS | 2018 | Values: 55.0 56.0 55.0 57.0 54.0 53.0 55.0 54.0 53.0 55.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:2.47 (3.5%) stddev-sans-first:1.88 09:45:05 INFO - PROCESS | 2018 | Values: 65.0 73.0 69.0 71.0 74.0 70.0 69.0 69.0 70.0 69.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.70 (2.0%) stddev-sans-first:1.74 09:45:05 INFO - PROCESS | 2018 | Values: 85.0 85.0 85.0 85.0 87.0 88.0 87.0 90.0 86.0 85.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:149.50 stddev:8.88 (5.9%) stddev-sans-first:9.34 09:45:05 INFO - PROCESS | 2018 | Values: 149.0 160.0 150.0 157.0 139.0 138.0 135.0 137.0 152.0 142.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:169.00 stddev:25.89 (15.3%) stddev-sans-first:26.72 09:45:05 INFO - PROCESS | 2018 | Values: 162.0 220.0 235.0 169.0 169.0 167.0 169.0 166.0 167.0 166.0 09:45:05 INFO - PROCESS | 2018 | 09:45:05 INFO - PROCESS | 2018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 09:45:05 INFO - PROCESS | 2018 | Values: 68.0 67.0 69.0 66.0 67.0 67.0 68.0 67.0 65.0 67.0 09:45:05 INFO - PROCESS | 2018 | -------- Summary: end -------- 09:45:05 INFO - PROCESS | 2018 | 09:45:06 INFO - TEST-INFO | 2018: exit 0 09:45:06 INFO - TEST-OK | kraken | took 59472ms 09:45:06 INFO - SUITE-END | took 1176s 09:45:06 INFO - Completed test suite (00:19:36) 09:45:06 INFO - javascript benchmark 09:45:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.5362449257095, 3316.2704205074883, 3342.9665703342966, 3344.08037789608, 3361.705743288833, 5509.504144626982, 5639.15412688097, 5663.518600918922, 5709.4576015278535, 5712.086066229404, 5623.212750214963, 5628.971855140729, 5650.5479561635075, 5701.6864072476, 5759.884802303962, 5114.181730923053, 5164.819231326905, 5167.7932882684645, 5177.534021938025, 5238.161894096946, 5310.787568497255, 5311.521963023347, 5328.520433161015, 5343.7328133593355, 5349.09065458871, 5082.567981721558, 5252.264682944391, 5253.238280449314, 5271.28837606922, 5273.472652734734, 5142.845714628567, 5182.144946083891, 5190.377154741455, 5191.32512773337, 5192.350956130484, 5052.267421223939, 5068.290439338495, 5161.690298582097, 5180.585553155738, 5185.585153187736, 5601.103823388238, 5607.663540187561, 5674.687892165929, 5696.943030569724, 5717.914231286534, 6026.879462410771, 6203.131561581382, 6213.658248796314, 6217.067439884054, 6229.127922090911, 5119.974400128012, 6183.598066125733, 6249.7187626556915, 6249.999999999978, 6319.3680631936895, 4920.507949205123, 5794.826155215308, 5795.0, 5801.245838041028, 5803.419658034247, 6126.816195514141, 6261.217347831521, 6297.307296197415, 6313.715882785285, 6314.652694101868, 6062.120992456069, 6131.478824299985, 6138.324784273726, 6138.570300078952, 6147.477464415575, 6246.281677607133, 6255.812325630239, 6259.0, 6261.874762504815, 6269.310375858652, 5989.460948514655, 6088.330283668793, 6157.907631385533, 6170.722317495633, 6194.876102478015, 5113.284140220372, 6190.442860142609, 6228.314885362606, 6259.561830671901, 6263.404976527223, 4933.087378834927, 4933.58064564516, 4936.333594964705, 4937.0, 4945.826896058621, 4334.869953901388, 4407.030453300269, 4410.757408342508, 4432.202203603318, 4433.024734558457, 5587.329520457572, 5650.491455769001, 5660.943390566042, 5693.572982026365, 5713.857153571194, 6268.717907694165, 6301.275353334425, 6307.148534947723, 6307.810765677037, 6314.526410519229, 5405.108157154104, 5609.411011843779, 5710.2862142232225, 5716.799912003143, 5724.971375143097, 5383.623146379716, 5412.07994640912, 5413.458654134555, 5432.375276843135, 5436.700981446058, 5328.094223981855, 6246.094316324198, 6295.307516173309, 6300.653464059521, 6302.338254483305, 6048.6975651218145, 6171.290301615371, 6258.405451482284, 6282.780102696383, 6292.402221788922, 6282.340354262737, 6295.937040629535, 6296.590721603081, 6298.464630506458, 6318.399752023551, 6113.786017489367, 6141.986572215535, 6158.599691020069, 6181.721822518088, 6194.690265486617, 5893.823185304448, 6065.120557519223, 6088.847778805565, 6229.283632382334, 6248.875022499616, 5786.132080188006, 5788.016037273589, 5810.1575271586225, 5811.79658711943, 5824.796132135355, 5771.711414429178, 5825.097109947965, 5829.15477255804, 5846.795362162304, 5852.619579727304, 4905.411350637946, 5688.345840228427, 5688.943110568841, 5707.343655479507, 5708.80019199326, 5958.702064896651, 6033.396660333931, 6046.0930860369535, 6107.358727333566, 6114.5414093942245, 4927.531884470969, 5897.557683173865, 5908.881822363614, 5919.763209471573, 5931.110333450017], "value": 5630.956111209803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.2340739927215, 502.7008929686835, 521.5801279969626, 529.872830520675, 559.7760895641741, 31195.064148075537, 31301.686983130163, 40280.59719402805, 41313.0, 41335.17329653405, 42649.14701705964, 43161.920951976215, 43177.920551986215, 43212.703618891406, 43240.81110266772, 9652.75868103296, 9844.556994935245, 9866.408015519057, 9869.407835529892, 9872.407655540655, 8797.07630698777, 9012.098790121001, 9714.0, 11898.64304070875, 12166.878331216707, 12181.20822146562, 12234.632961011139, 12235.63293101204, 12259.080568957319, 12264.448099835485, 12019.879801202007, 12167.878321216851, 12205.572804951784, 12225.755484890342, 12230.9603683687, 11899.524019039229, 11977.281363118242, 11985.700357491045, 11988.580399686056, 11999.640010799603, 40414.59585404167, 40712.0, 40741.0, 40767.59232407697, 40918.79540602308, 3421.26442814796, 3477.1307173206696, 3490.2321489272317, 3506.281212351462, 3619.9276014479565, 31257.8437107813, 32604.6739532604, 32698.836505817555, 32701.50947735786, 32701.67298327034, 3291.2265617580088, 3302.290007648367, 3303.355845610107, 3338.565986421774, 3445.8277086145595, 503527.0, 507380.0, 508010.0, 508454.0, 511211.0, 60461.39538604557, 60641.696791516646, 60758.39241607616, 60807.39192608106, 60892.39107608956, 64109.717805644555, 64236.0, 64254.357456424834, 64303.35696643067, 64321.67839160868, 16194.67610647804, 16497.927634703705, 16506.009639421674, 16516.0, 16545.66908661844, 11519.48162332697, 12695.746085078432, 12807.167534110253, 12820.80768788469, 12824.551140710031, 14823.70352592942, 15289.15909624959, 15302.540923772305, 15312.0, 15335.616609584626, 5583.302087239095, 6970.268121847234, 7074.823129421806, 7211.990321355014, 7372.373348265351, 842.2882664148784, 927.6428574998539, 945.6926498887889, 956.3544607389983, 995.2436148527026, 25532.361690957874, 25783.355416114748, 28103.0, 29176.854115729286, 30063.549046764318, 872.5157537566585, 977.3207620703542, 1035.2701345551368, 1074.3285446595878, 1111.7832022755647, 14809.481668141563, 14931.552053438414, 15492.845071549365, 15544.844551554566, 16000.439984600484, 671650.0, 723570.0, 725060.0, 725790.0, 931257.0, 50752.238716419284, 51798.1870634526, 51968.480315196364, 54842.451575484534, 59527.70236148878, 1266.6896610330527, 1313.5205649937704, 1354.6951935814363, 1404.1434724817648, 1424.6794471243886, 29918.846887134358, 30852.691473084982, 30897.91857284984, 31371.21571960628, 31565.368692626478, 50113.498865010886, 50509.49490505195, 50607.0, 50638.49361506485, 50796.49203507917, 556248.0, 557397.0, 559926.0036998215, 560393.0, 561141.0, 23285.88357058204, 26006.73993260043, 26587.0, 26601.66991650371, 27246.5913011301, 46720.766396167804, 46976.0, 47791.522084778706, 47878.28182577334, 48498.75750621365, 38370.80814595909, 38644.80677596594, 38798.41802373023, 39974.20051598894, 40254.0, 38087.80956095202, 38372.04069898163, 38716.0, 39365.80317098396, 39966.2006759869, 37420.0, 38025.66910158131, 38692.80653596714, 38699.6130038696, 38899.61100389073, 31121.68878311188, 31122.688773112885, 33096.83451582823, 33939.66060339365, 34198.31603367969, 25093.247202583952, 25286.49427011486, 25316.113936012887, 25344.873275633505, 25818.354541135872], "value": 20285.09276853924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.6718611086137, 356.65048252712324, 375.79894756305384, 387.6588602030214, 412.1371401266276, 15771.369145234192, 16820.91589542052, 20898.89550552249, 20992.8950355248, 21037.685854555988, 17338.47984560462, 20270.69593956092, 20721.481962950897, 20908.790912090873, 20942.89528552355, 5362.195670649405, 5365.386724631324, 5440.619156659035, 5537.889242215153, 5542.86142846428, 5356.9732151339185, 5480.150576660604, 5481.12302031675, 5491.423400542945, 5504.64219825712, 3901.0, 5257.658252213594, 5942.376050514698, 5970.820875373745, 5998.310194327642, 5673.886522269573, 5845.327787304472, 5939.099488163789, 5966.254218222723, 5973.283206015284, 5724.656520608777, 5729.971350143264, 5733.197352370671, 5734.197212390269, 5737.88524229513, 12671.0, 15955.840441595552, 20241.089150988242, 23184.3044708659, 23476.530469390687, 2309.769023097677, 2331.5803155432013, 2429.6112621980574, 2581.586946088617, 2856.985715071432, 9872.308938374317, 10065.345752526062, 10430.322029068086, 10523.84214236787, 14882.404703811835, 1891.498752830501, 1894.8199921007483, 1920.69268916974, 1938.3990962801577, 1970.231609672229, 121172.78827211703, 125148.0, 125320.48077115402, 127675.72324276732, 128339.35830320882, 11366.886331136748, 11520.020798232077, 11593.76812463746, 11599.536018559333, 11845.763084738257, 14711.0, 14712.264386780618, 14716.705665886622, 14717.484888028868, 14717.705645887023, 8338.458000229966, 8496.830063398698, 8509.319254459628, 8557.614907329185, 8666.393352465268, 8434.831303374021, 8439.70461033861, 8459.83080338402, 8600.655973761104, 8615.483071015758, 4543.954560454353, 4556.88607784808, 4557.95442045582, 4562.771861406983, 4641.559051890133, 1846.981530184708, 1917.664408728495, 1918.6162767446567, 1918.7505624269036, 1919.7216403621396, 873.8863947686888, 890.3366991591306, 944.9574769135405, 959.6353385713384, 1029.6910926721953, 18224.08879556017, 20658.483537911674, 21116.78883211179, 21218.681719774217, 22182.2272215973, 882.1311008656468, 896.6323807239, 935.457434687893, 951.5052172870207, 952.1620973543376, 9315.197138703996, 11018.84302148279, 11413.402123702688, 11460.426978651034, 11650.126240531994, 527508.0, 531533.0, 533689.0, 552059.0, 556795.0, 98523.0, 123671.0, 124935.37532312462, 127522.0, 128429.0, 944.6788092048737, 976.7899901521065, 1010.5604062232952, 1016.8423894296396, 1019.7093828258911, 15196.392144314546, 19805.60388792245, 20066.498337541096, 20095.799042009392, 20134.395968120978, 41604.79197603992, 52610.736946315024, 57093.0, 58976.41023589709, 59817.401825982924, 76786.23213767791, 77597.61201194183, 80823.0, 83577.74633380625, 84985.0, 7890.605469726376, 8044.798880028046, 8150.83698326042, 8210.220029097227, 8454.408191426786, 11770.88229117732, 12018.819717704417, 13075.673108172372, 13132.752388523075, 13154.934225328812, 10829.0, 11182.384968826467, 11213.327200368005, 11409.771804564029, 11606.825897611374, 10655.360678359324, 11020.944895275472, 11024.50389732448, 11243.60647377338, 11633.0, 10798.892011080103, 11162.888371116509, 11714.9456548911, 11727.882721172678, 11742.58900938463, 7342.751732205431, 7974.043114826258, 8209.958950205211, 8342.83314333722, 8422.368322375969, 9000.54997250148, 11029.393383363991, 11465.082793376676, 11489.0, 11491.482883270106], "value": 9479.358868941437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.4147445861045, 1505.2849896299256, 1526.9464069791845, 1665.159094657198, 1816.8001519832824, 7427.962860185698, 8230.835383292331, 8491.150884911505, 8558.529280889548, 8593.95703021484, 8353.206445387694, 8417.074121846592, 8418.579071046453, 8421.873671894911, 8550.657973681045, 2337.4273303040736, 2371.1108334374608, 2374.3114496795906, 2375.0, 2384.463495713468, 2316.9073237070497, 2353.2469609724894, 2359.4101474631343, 2368.4789346343778, 2372.774586414288, 2327.6857624220766, 2347.835651504395, 2356.06935260572, 2367.065009321317, 2370.5851475991717, 2269.3305474884946, 2275.3515248154195, 2317.5249073939804, 2318.9188378406843, 2335.8948847301913, 2327.1156960355124, 2327.93016209514, 2336.5677349690363, 2338.6608941703357, 2341.4146463384154, 8432.789180270482, 8484.490930544187, 8511.446755960842, 8564.100769419183, 8566.957165214197, 5038.722870242135, 5251.921221181686, 5253.3958594761325, 5262.23697563855, 5320.361556613192, 3391.7625766196375, 3535.4696795480627, 3607.9639203608153, 3615.963840361589, 3617.8371973261264, 921.1801496667971, 931.1852129386787, 955.2262667239559, 969.9175570076552, 972.8589354543551, 10816.080633146192, 10906.34561926287, 10964.56141754337, 10971.0, 11001.559937602566, 4323.589259020388, 4342.956570434255, 4516.299973504112, 4526.592606665416, 4558.27067669178, 8711.738647840575, 8737.825243495094, 8751.649934002697, 8806.559672016374, 8811.427257228259, 5102.311187989574, 5107.080725469451, 5124.128898087334, 5156.845294641167, 5159.071367153873, 4314.633256173261, 4456.665750068758, 4633.443986721615, 4751.59611433032, 4799.472058073609, 3616.5298511193378, 3678.3378991781738, 3752.0057184846037, 3764.5482542095124, 3796.9050773730323, 1113.897241730697, 1161.2103769436865, 1163.2264544078262, 1169.1698893785338, 1178.6287319494331, 896.4845214001975, 904.7738065483629, 919.8206349761866, 947.4599379557061, 967.3132076225818, 5442.782288708487, 5694.686792226385, 5752.511036561939, 5781.8554536136935, 5818.5345172386105, 434.61536540162183, 449.07938725612365, 467.97513445554125, 963.710886733977, 1066.2323127348297, 3739.85040598373, 3938.232044751246, 4015.859444919414, 4039.7374170678813, 4062.3297155969526, 9965.501724913725, 10328.586856525804, 10344.120749736358, 10410.219233557362, 10425.0096240857, 9466.432014079177, 9857.802843943224, 10011.299209055442, 10238.53926573306, 10261.230407719451, 7598.430117741192, 7714.344280736088, 7863.174366691415, 8047.195280471906, 8111.797205069921, 5800.187973683772, 5851.707414629337, 5883.676397797991, 5909.231799866162, 5992.891315106719, 9302.0, 9576.425414475154, 9689.515524223902, 9703.272254580794, 9767.120959113714, 9429.245660347018, 9493.810123797624, 9744.805103898025, 9870.555824987749, 9985.850212246967, 6600.207975043026, 6755.729770809309, 6772.312752279823, 7277.345038946309, 7443.54850804088, 7669.156392796899, 8242.423030387816, 8249.175082491704, 8257.587120644064, 8330.958630171228, 7253.673584688596, 7273.454490913308, 7289.2710728928805, 7289.927100728924, 7465.925340746523, 7100.396466300423, 7133.500654954103, 7190.101237345332, 7193.892091618525, 7242.348188663045, 6825.897611535732, 6835.179778426621, 6839.863202736017, 6894.069300644549, 7017.543859649107, 4230.794223646246, 4791.8978634914865, 4873.220284754422, 4877.000214955997, 5065.240213967934, 4863.3434486343895, 4921.926171107365, 4968.882001549767, 4969.726665033458, 5037.345145131256], "value": 4405.691495154312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3128819054745, 300.8285277391887, 306.1656984716646, 306.37652377411956, 309.498612248158, 3895.7272990890647, 4371.03303513419, 4830.864746784511, 5281.524662780349, 5330.920036199455, 5098.980203959204, 5225.6603320784125, 5294.285271488348, 5304.602154838383, 5341.679499230049, 3258.8533515991717, 3357.875111837537, 3374.6287908330187, 3575.7675751076226, 3800.327855743464, 3335.6997870191676, 4001.6398524132824, 4023.376376661622, 4025.5508017113816, 4049.2508885856064, 3269.9182520436943, 3276.9016929492154, 3957.861474848381, 3985.8604948826796, 3997.2405243003736, 3531.514975980516, 3785.5646600641003, 3865.4974853269177, 3946.48695669564, 3981.7610943343348, 2742.3966727319957, 3474.1488335357744, 3479.982600087009, 3489.307685772398, 3500.2299494111253, 5047.671901326402, 5077.2637967494875, 5088.516590923857, 5108.284840122349, 5112.258722485256, 4094.897627559335, 4243.172581346638, 4356.499002614708, 4440.937331442158, 4495.550444955511, 5367.865803354908, 5375.704336261504, 5413.891722165535, 5451.672899626035, 5463.7814487420455, 3017.7476347315837, 3506.474028895686, 3553.751237413382, 3643.7813731175947, 3834.194819087995, 4894.021195760862, 5434.592405569559, 5601.859953501154, 5750.6262092963825, 5775.740091695884, 3356.0466789225325, 3816.255830113101, 3868.7947869713994, 3883.689304855605, 3892.6107389260847, 3315.8176300303717, 3897.824597893102, 3954.0, 3955.0337247064704, 3958.1094253792667, 3701.9074523136596, 4474.530174331649, 4482.932756008662, 4489.0, 4493.865413928358, 4540.846139631542, 5146.529665760456, 5429.914017196497, 5439.673619582759, 5449.482299181651, 1326.8986741005135, 1358.130796290375, 1361.2921280933858, 1361.584716661408, 1363.8704323089291, 667.6695035957135, 804.8752443371287, 841.6254766628791, 842.7598134531629, 843.7890527368158, 4286.249906266391, 4516.548345165523, 4889.046635906036, 4924.72913989734, 5099.286099946011, 5471.50756431923, 5474.890502189934, 5744.339400968858, 5773.566982476331, 5784.4504772046585, 4146.398772178018, 4268.758901576697, 5124.692518448905, 5203.505666961632, 5216.713080780518, 2464.3223113643535, 2483.540544999181, 2638.511875303075, 2958.304798372381, 3022.7757758108, 5777.45114214149, 5878.323992740804, 5895.587308888336, 5901.203337549462, 5922.940770592325, 5378.462153784591, 5793.362730099686, 5830.941690583125, 5842.750541041644, 5851.912221316684, 5519.978803921287, 5920.2303700519515, 5959.5828292020005, 5995.650978529796, 6013.51891848651, 4994.650374473752, 5179.870503237449, 5564.0, 5726.79956201531, 5832.766689332379, 4769.73766442849, 5199.908019315986, 5288.550473209821, 5681.488666020078, 5780.0, 4913.877153071202, 4937.7531123444405, 4966.900661986668, 5480.917786233289, 6003.609765365237, 3353.346097510962, 3946.8026598670526, 3997.6002399760955, 4013.317735984948, 4032.9596704032583, 4776.95223047779, 4869.805207791649, 5443.7278136092245, 5561.304836895388, 5685.374608793112, 5059.620528460307, 5085.084684756779, 5446.863828404322, 5552.5557955362665, 5573.136163894603, 4909.386326709161, 5345.278387417648, 5459.235707000944, 5608.523275521463, 5608.775648974159, 4921.384826896638, 4946.802127914843, 5447.455254474679, 5492.752826122914, 5580.414056524007, 4281.336392859112, 5261.0, 5383.219433182088, 5512.779488820403, 5555.416681248411, 5104.846854594368, 5314.0, 5488.38092762644, 5537.307836520435, 5579.9163012555655], "value": 3969.2088183928768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.6310473896465, 709.939655129314, 763.912150102738, 797.4736673795296, 805.3034125481461, 15889.920550397246, 16756.497305080837, 16780.160991950415, 16800.07599582024, 16811.747823782654, 14912.254387280647, 15056.322465489053, 15062.472813451532, 15084.924575377136, 15092.39630414785, 676.6278546799265, 700.4956431369405, 719.2447929673822, 822.3708862720009, 845.8477474054667, 852.2585350744861, 864.2437866866492, 867.7223288547667, 867.9869801952944, 870.503812826689, 921.7465197070792, 925.9212966897821, 927.8608208768671, 928.9163975242227, 929.0755698080419, 640.6092283706935, 741.0033504935852, 914.3416739947228, 915.9404638698463, 917.610015743313, 659.6932426421737, 678.131991051455, 678.8235058884676, 678.8336857469902, 680.4148432348177, 14645.92677036608, 14668.779968300483, 14684.779728304084, 14710.632234194123, 14723.852761472355, 13675.589732307948, 13938.790918136236, 13944.790828137586, 14028.298585070706, 14354.210518421483, 11309.547618095348, 12581.874181258161, 12695.524198761008, 12750.29873356965, 12913.677158071123, 4601.976990115061, 4632.7220366777765, 4672.183132000647, 4762.880927976794, 4784.808607655689, 113692.43153784178, 115103.0, 116055.41972290084, 117764.0, 118079.99999999914, 10749.731256718645, 10880.836787448035, 10915.399653019002, 11040.454336392912, 11141.2201145919, 20522.897385513275, 20794.0, 20808.687869681966, 20815.37553873386, 20833.791662083186, 6647.86704265912, 7787.10448298453, 8133.0646975598565, 8194.836103277901, 8517.23344898962, 4495.280755079171, 4582.495925448198, 4592.5407459254475, 4619.284010978304, 4629.884252893705, 3538.4515400113023, 3640.12636967126, 3706.8887933362043, 3724.683401910868, 3758.699304055669, 626.123427201921, 626.123427201921, 628.3119983617931, 637.4931929116364, 655.6164643683499, 521.9295395121686, 556.9777208911598, 586.3784388548153, 638.9329819201944, 647.5531883000715, 9086.636534538544, 9369.953150234205, 9491.620335186653, 9598.42409455435, 9608.9039109608, 544.3658138268872, 569.9145128230798, 606.3996643323167, 617.7374615788272, 699.1575151941897, 3871.472268142243, 3993.24297309183, 4637.865944158325, 4690.624750019991, 4768.833090841873, 89756.6536501953, 98710.01289987152, 111737.32394014097, 143229.0, 149308.253458732, 81556.0, 109820.0, 114665.0, 116307.0, 140936.5906340944, 79365.0, 99017.99999999856, 102316.0, 103514.0, 110599.94000600037, 8577.0, 8613.353998450017, 9645.807083858424, 9682.70951871445, 9690.75773105678, 54508.454915451926, 58970.0, 60054.69972650109, 60402.69798650979, 60802.391976081446, 86838.0, 87162.0, 88120.55939720261, 90077.54961225152, 90216.0, 12917.483300668244, 13457.192568445924, 13492.392842322315, 13586.660333491742, 13912.860871391156, 14837.851621484078, 14885.702285954438, 15005.399784008518, 15008.699826003638, 15058.623534411727, 8562.11633440642, 13920.58238252854, 13938.790918136034, 14437.927810360881, 14842.925785371004, 14232.71534569282, 14420.567382978528, 14595.92702036483, 14743.336549855068, 14784.408623654934, 13672.974526910322, 13746.875937218994, 13755.31223438844, 13874.653133671336, 14262.928685356506, 10549.683509494727, 10695.197860160364, 11452.427378630868, 11534.711632209262, 11630.418479076181, 10782.0, 11624.88375116238, 11799.292042477478, 11846.99300559462, 11950.940245298718], "value": 7765.974375134907, "unit": "score"}], "name": "dromaeo_css", "value": 7265.24525932289, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 112.0, 106.0, 113.0, 113.0, 113.0, 115.0, 114.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 108.0, 133.0, 163.0, 109.0, 128.0, 128.0, 106.0, 183.0, 136.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 186.0, 185.0, 202.0, 267.0, 184.0, 179.0, 182.0, 182.0, 183.0], "value": 192.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 123.0, 119.0, 80.0, 61.0, 66.0, 84.0, 89.0, 56.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 137.0, 70.0, 71.0, 76.0, 119.0, 70.0, 70.0, 123.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 83.0, 86.0, 83.0, 88.0, 83.0, 88.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 92.0, 111.0, 152.0, 93.0, 92.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 84.0, 85.0, 86.0, 85.0, 87.0, 102.0, 132.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 57.0, 54.0, 53.0, 55.0, 54.0, 53.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 69.0, 71.0, 74.0, 70.0, 69.0, 69.0, 70.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 87.0, 88.0, 87.0, 90.0, 86.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 160.0, 150.0, 157.0, 139.0, 138.0, 135.0, 137.0, 152.0, 142.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 220.0, 235.0, 169.0, 169.0, 167.0, 169.0, 166.0, 167.0, 166.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 66.0, 67.0, 67.0, 68.0, 67.0, 65.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1490.9, "alertThreshold": 2.0}]} 09:45:06 INFO - Return code: 0 09:45:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:06 INFO - # TBPL SUCCESS # 09:45:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:45:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:45:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:45:06 INFO - 2016-08-22 09:45:06.649 screenresolution[2022:17651] starting screenresolution argv=screenresolution get 09:45:06 INFO - 2016-08-22 09:45:06.652 screenresolution[2022:17651] Display 0: 1600x1200x32@60 09:45:06 INFO - 2016-08-22 09:45:06.657 screenresolution[2023:17654] starting screenresolution argv=screenresolution list 09:45:06 INFO - Available Modes on Display 0 09:45:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:45:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:45:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:45:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:45:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:45:06 INFO - Intel Iris: 09:45:06 INFO - Chipset Model: Intel Iris 09:45:06 INFO - Type: GPU 09:45:06 INFO - Bus: Built-In 09:45:06 INFO - VRAM (Dynamic, Max): 1536 MB 09:45:06 INFO - Vendor: Intel (0x8086) 09:45:06 INFO - Device ID: 0x0a2e 09:45:06 INFO - Revision ID: 0x0009 09:45:06 INFO - Displays: 09:45:06 INFO - Display: 09:45:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:45:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:45:06 INFO - Display Serial Number: 1600x1200 60 09:45:06 INFO - Main Display: Yes 09:45:06 INFO - Mirror: Off 09:45:06 INFO - Online: Yes 09:45:06 INFO - Rotation: Supported 09:45:06 INFO - Return code: 0 09:45:06 INFO - Running post-action listener: _resource_record_post_action 09:45:06 INFO - [mozharness: 2016-08-22 16:45:06.897074Z] Finished run-tests step (success) 09:45:06 INFO - Running post-run listener: _resource_record_post_run 09:45:06 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 806912; Write bytes: 703321600; Read time: 11; Write time: 2307 09:45:06 INFO - TinderboxPrint: CPU usage
53.4% 09:45:06 INFO - TinderboxPrint: I/O read bytes / time
806,912 / 11 09:45:06 INFO - TinderboxPrint: I/O write bytes / time
703,321,600 / 2,307 09:45:06 INFO - TinderboxPrint: CPU idle
2,257.6 (46.6%) 09:45:06 INFO - TinderboxPrint: CPU system
968.1 (20.0%) 09:45:06 INFO - TinderboxPrint: CPU user
1,619.9 (33.4%) 09:45:06 INFO - TinderboxPrint: Swap in / out
407,216,128 / 0 09:45:06 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399700480; Write bytes: 394991104; Read time: 29470; Write time: 815 09:45:06 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 806912; Write bytes: 292433920; Read time: 11; Write time: 1451 09:45:07 INFO - Running post-run listener: _upload_blobber_files 09:45:07 INFO - Blob upload gear active. 09:45:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:07 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 09:45:07 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'] 09:45:07 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 09:45:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:08 INFO - (blobuploader) - INFO - Done attempting. 09:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:09 INFO - (blobuploader) - INFO - Done attempting. 09:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:12 INFO - (blobuploader) - INFO - Done attempting. 09:45:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:12 INFO - Return code: 0 09:45:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f347613c6bb1db6bf6ce09cd4229e199848b4f68f94d951379f08e4c3e3a98436ec24c9607da23b7576fc3460718c77d962bb83e396b0b606d642acc434e87b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58f52d85f0abdc60aa61be2d6ce1df277fec27d5fdf0454e4d77ae27b7bb713c4eb6d2831365b1fd901dc8d5297f76d7b74cf0f724bd22c1cdb7be0ce7cdf334", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f699c83673576b4f8a24bd801b0b4b35342ea208db39eb6d35678885d7e51857df09e7ce4a21f68802acbf449bc1166dae1a3944afa0eecdf6a6a6ceccd0b2ed"} 09:45:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:12 INFO - Contents: 09:45:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f347613c6bb1db6bf6ce09cd4229e199848b4f68f94d951379f08e4c3e3a98436ec24c9607da23b7576fc3460718c77d962bb83e396b0b606d642acc434e87b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58f52d85f0abdc60aa61be2d6ce1df277fec27d5fdf0454e4d77ae27b7bb713c4eb6d2831365b1fd901dc8d5297f76d7b74cf0f724bd22c1cdb7be0ce7cdf334", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f699c83673576b4f8a24bd801b0b4b35342ea208db39eb6d35678885d7e51857df09e7ce4a21f68802acbf449bc1166dae1a3944afa0eecdf6a6a6ceccd0b2ed"} 09:45:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:12 INFO - Copying logs to upload dir... 09:45:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.491262 ========= master_lag: 2.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-22 09:45:15.085055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:45:15.089074) ========= 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.ogvqUt0G09/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.sNmigzm8zh/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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/2f347613c6bb1db6bf6ce09cd4229e199848b4f68f94d951379f08e4c3e3a98436ec24c9607da23b7576fc3460718c77d962bb83e396b0b606d642acc434e87b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58f52d85f0abdc60aa61be2d6ce1df277fec27d5fdf0454e4d77ae27b7bb713c4eb6d2831365b1fd901dc8d5297f76d7b74cf0f724bd22c1cdb7be0ce7cdf334", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f699c83673576b4f8a24bd801b0b4b35342ea208db39eb6d35678885d7e51857df09e7ce4a21f68802acbf449bc1166dae1a3944afa0eecdf6a6a6ceccd0b2ed"} build_url:https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/Smb4tFs6RIq0j3gFgHr57g/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/2f347613c6bb1db6bf6ce09cd4229e199848b4f68f94d951379f08e4c3e3a98436ec24c9607da23b7576fc3460718c77d962bb83e396b0b606d642acc434e87b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58f52d85f0abdc60aa61be2d6ce1df277fec27d5fdf0454e4d77ae27b7bb713c4eb6d2831365b1fd901dc8d5297f76d7b74cf0f724bd22c1cdb7be0ce7cdf334", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f699c83673576b4f8a24bd801b0b4b35342ea208db39eb6d35678885d7e51857df09e7ce4a21f68802acbf449bc1166dae1a3944afa0eecdf6a6a6ceccd0b2ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:45:15.124069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:45:15.124664) ========= 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.ogvqUt0G09/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.sNmigzm8zh/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.004468 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:45:15.176999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:45:15.177547) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:45:15.178632) ========= ========= Total master_lag: 2.56 =========