builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0062 starttime: 1471174001.58 results: success (0) buildid: 20160814030203 builduid: 8793c526a9c445938eb1935fff39321d revision: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:41.584028) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:41.584568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:41.584877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:41.766153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:41.766437) ========= 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.9lMzTxeEMX/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.NksRiTjbZR/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-14 04:26:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2016-08-14 04:26:42 (14.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.481593 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:42.275582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:42.275907) ========= 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.9lMzTxeEMX/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.NksRiTjbZR/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.028052 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:42.324398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-14 04:26:42.324728) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9lMzTxeEMX/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.NksRiTjbZR/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-14 04:26:42,395 truncating revision to first 12 chars 2016-08-14 04:26:42,395 Setting DEBUG logging. 2016-08-14 04:26:42,395 attempt 1/10 2016-08-14 04:26:42,395 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6e191a55c3d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-14 04:26:43,506 unpacking tar archive at: mozilla-central-6e191a55c3d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.395844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-14 04:26:43.742177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:43.742498) ========= script_repo_revision: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:43.742894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:43.743167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-14 04:26:43.761884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-14 04:26:43.762270) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9lMzTxeEMX/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.NksRiTjbZR/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:26:43 INFO - MultiFileLogger online at 20160814 04:26:43 in /builds/slave/test 04:26:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:26:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:43 INFO - {'append_to_log': False, 04:26:43 INFO - 'base_work_dir': '/builds/slave/test', 04:26:43 INFO - 'blob_upload_branch': 'Firefox', 04:26:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:43 INFO - 'branch': 'Firefox', 04:26:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:43 INFO - 'config_files': ('talos/mac_config.py',), 04:26:43 INFO - 'default_actions': ('clobber', 04:26:43 INFO - 'read-buildbot-config', 04:26:43 INFO - 'download-and-extract', 04:26:43 INFO - 'populate-webroot', 04:26:43 INFO - 'create-virtualenv', 04:26:43 INFO - 'install', 04:26:43 INFO - 'run-tests'), 04:26:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:43 INFO - 'download_minidump_stackwalk': True, 04:26:43 INFO - 'download_symbols': 'ondemand', 04:26:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:43 INFO - 'installer_path': 'installer.exe', 04:26:43 INFO - 'log_level': 'info', 04:26:43 INFO - 'log_name': 'talos', 04:26:43 INFO - 'log_to_console': True, 04:26:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:26:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:26:43 INFO - 'opt_config_files': (), 04:26:43 INFO - 'pip_index': False, 04:26:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:43 INFO - 'cmd': ('bash', 04:26:43 INFO - '-c', 04:26:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:43 INFO - 'enabled': True, 04:26:43 INFO - 'halt_on_failure': False, 04:26:43 INFO - 'name': 'check_screen_resolution'},), 04:26:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:43 INFO - 'cmd': ('bash', 04:26:43 INFO - '-c', 04:26:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:43 INFO - 'enabled': True, 04:26:43 INFO - 'halt_on_failure': False, 04:26:43 INFO - 'name': 'check_screen_resolution'},), 04:26:43 INFO - 'run_cmd_checks_enabled': True, 04:26:43 INFO - 'sps_profile': False, 04:26:43 INFO - 'sps_profile_interval': 0, 04:26:43 INFO - 'suite': 'dromaeojs', 04:26:43 INFO - 'system_bits': '32', 04:26:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:43 INFO - 'title': 't-yosemite-r7-0062', 04:26:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:43 INFO - 'use_talos_json': True, 04:26:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:43 INFO - 'work_dir': 'build'} 04:26:43 INFO - [mozharness: 2016-08-14 11:26:43.966257Z] Running clobber step. 04:26:43 INFO - Running pre-action listener: _resource_record_pre_action 04:26:43 INFO - Running main action method: clobber 04:26:43 INFO - rmtree: /builds/slave/test/build 04:26:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:46 INFO - Running post-action listener: _resource_record_post_action 04:26:46 INFO - [mozharness: 2016-08-14 11:26:46.054639Z] Finished clobber step (success) 04:26:46 INFO - [mozharness: 2016-08-14 11:26:46.054776Z] Running read-buildbot-config step. 04:26:46 INFO - Running pre-action listener: _resource_record_pre_action 04:26:46 INFO - Running main action method: read_buildbot_config 04:26:46 INFO - Using buildbot properties: 04:26:46 INFO - { 04:26:46 INFO - "project": "", 04:26:46 INFO - "product": "firefox", 04:26:46 INFO - "script_repo_revision": "production", 04:26:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:26:46 INFO - "repository": "", 04:26:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:26:46 INFO - "buildid": "20160814030203", 04:26:46 INFO - "stage_platform": "macosx64", 04:26:46 INFO - "basedir": "/builds/slave/test", 04:26:46 INFO - "nightly_build": "True", 04:26:46 INFO - "buildnumber": 319, 04:26:46 INFO - "slavename": "t-yosemite-r7-0062", 04:26:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:26:46 INFO - "platform": "yosemite_r7", 04:26:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:26:46 INFO - "branch": "mozilla-central", 04:26:46 INFO - "repo_path": "mozilla-central", 04:26:46 INFO - "revision": "6e191a55c3d23e83e6a2e72e4e80c1dc21516493", 04:26:46 INFO - "pgo_build": "False", 04:26:46 INFO - "builduid": "8793c526a9c445938eb1935fff39321d", 04:26:46 INFO - "slavebuilddir": "test" 04:26:46 INFO - } 04:26:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:26:46 INFO - Running post-action listener: _resource_record_post_action 04:26:46 INFO - [mozharness: 2016-08-14 11:26:46.058270Z] Finished read-buildbot-config step (success) 04:26:46 INFO - [mozharness: 2016-08-14 11:26:46.058389Z] Running download-and-extract step. 04:26:46 INFO - Running pre-action listener: _resource_record_pre_action 04:26:46 INFO - Running main action method: download_and_extract 04:26:46 INFO - mkdir: /builds/slave/test/build/tests 04:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:46 INFO - trying https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:26:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:26:46 INFO - Downloaded 1199 bytes. 04:26:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:26:46 INFO - Using the following test package requirements: 04:26:46 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:26:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:26:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:26:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'jsshell-mac.zip'], 04:26:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:26:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:26:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:26:46 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:26:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:26:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:26:46 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:26:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:46 INFO - trying https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:26:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:26:48 INFO - Downloaded 16330508 bytes. 04:26:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:26:55 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 04:26:55 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')]} 04:26:55 INFO - trying https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:26:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:26:56 INFO - Downloaded 16330508 bytes. 04:26:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:27: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')]} 04:27:02 INFO - trying https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:27:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:27:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:27:03 INFO - Downloaded 14413719 bytes. 04:27:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:27:04 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')]} 04:27:04 INFO - trying https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:27:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:27:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/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 04:27:07 INFO - Downloaded 111177694 bytes. 04:27:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:27:07 INFO - mkdir: /builds/slave/test/properties 04:27:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:07 INFO - Contents: 04:27:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:27:08 INFO - Running post-action listener: _resource_record_post_action 04:27:08 INFO - Running post-action listener: set_extra_try_arguments 04:27:08 INFO - [mozharness: 2016-08-14 11:27:08.660755Z] Finished download-and-extract step (success) 04:27:08 INFO - [mozharness: 2016-08-14 11:27:08.660886Z] Running populate-webroot step. 04:27:08 INFO - Running pre-action listener: _resource_record_pre_action 04:27:08 INFO - Running main action method: populate_webroot 04:27:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:08 INFO - '--tppagecycles', 04:27:08 INFO - '7'], 04:27:08 INFO - 'tests': ['tsvgm']}}, 04:27:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['damp', 'tps']}, 04:27:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'tests': ['damp', 'tps']}, 04:27:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['dromaeo_dom']}, 04:27:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['basic_compositor_video']}, 04:27:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['a11yr', 04:27:08 INFO - 'ts_paint', 04:27:08 INFO - 'tpaint', 04:27:08 INFO - 'sessionrestore', 04:27:08 INFO - 'sessionrestore_no_auto_restore', 04:27:08 INFO - 'tabpaint']}, 04:27:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:08 INFO - 'ts_paint', 04:27:08 INFO - 'tpaint', 04:27:08 INFO - 'sessionrestore', 04:27:08 INFO - 'sessionrestore_no_auto_restore', 04:27:08 INFO - 'tabpaint']}, 04:27:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:08 INFO - 'ts_paint', 04:27:08 INFO - 'tpaint', 04:27:08 INFO - 'sessionrestore', 04:27:08 INFO - 'sessionrestore_no_auto_restore', 04:27:08 INFO - 'tabpaint']}, 04:27:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:08 INFO - 'ts_paint', 04:27:08 INFO - 'tpaint', 04:27:08 INFO - 'sessionrestore', 04:27:08 INFO - 'sessionrestore_no_auto_restore', 04:27:08 INFO - 'tabpaint']}, 04:27:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['a11yr', 04:27:08 INFO - 'ts_paint', 04:27:08 INFO - 'tpaint', 04:27:08 INFO - 'sessionrestore', 04:27:08 INFO - 'sessionrestore_no_auto_restore', 04:27:08 INFO - 'tabpaint']}, 04:27:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['a11yr', 04:27:08 INFO - 'ts_paint', 04:27:08 INFO - 'tpaint', 04:27:08 INFO - 'sessionrestore', 04:27:08 INFO - 'sessionrestore_no_auto_restore', 04:27:08 INFO - 'tabpaint']}, 04:27:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['tsvgx', 04:27:08 INFO - 'tsvgr_opacity', 04:27:08 INFO - 'tart', 04:27:08 INFO - 'tscrollx', 04:27:08 INFO - 'cart']}, 04:27:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:08 INFO - 'tsvgr_opacity', 04:27:08 INFO - 'tart', 04:27:08 INFO - 'tscrollx', 04:27:08 INFO - 'cart']}, 04:27:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'talos_options': ['--disable-e10s'], 04:27:08 INFO - 'tests': ['tp5o']}, 04:27:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'tests': ['tp5o']}, 04:27:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'talos_options': ['--disable-e10s', 04:27:08 INFO - '--xperf_path', 04:27:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:08 INFO - 'tests': ['tp5n']}, 04:27:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:08 INFO - 'talos_options': ['--xperf_path', 04:27:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:08 INFO - 'tests': ['tp5n']}}, 04:27:08 INFO - 'talos.zip': {'path': '', 04:27:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:08 INFO - Running post-action listener: _resource_record_post_action 04:27:08 INFO - [mozharness: 2016-08-14 11:27:08.680190Z] Finished populate-webroot step (success) 04:27:08 INFO - [mozharness: 2016-08-14 11:27:08.680306Z] Running create-virtualenv step. 04:27:08 INFO - Running pre-action listener: _resource_record_pre_action 04:27:08 INFO - Running main action method: create_virtualenv 04:27:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:08 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 04:27:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:08 INFO - Using real prefix '/tools/python27' 04:27:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:09 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:12 INFO - Installing pip.................done. 04:27:12 INFO - Return code: 0 04:27:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:12 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')]} 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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')]} 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:12 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 04:27:12 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 04:27:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:12 INFO - 'HOME': '/Users/cltbld', 04:27:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:12 INFO - 'LOGNAME': 'cltbld', 04:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:12 INFO - 'MOZ_NO_REMOTE': '1', 04:27:12 INFO - 'NO_EM_RESTART': '1', 04:27:12 INFO - 'PAGER': '/bin/cat', 04:27:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:12 INFO - 'PWD': '/builds/slave/test', 04:27:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:12 INFO - 'SHELL': '/bin/bash', 04:27:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:12 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:12 INFO - 'USER': 'cltbld', 04:27:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:12 INFO - 'XPC_FLAGS': '0x0', 04:27:12 INFO - 'XPC_SERVICE_NAME': '0', 04:27:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:12 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 04:27:12 INFO - Cleaning up... 04:27:12 INFO - Return code: 0 04:27:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:12 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')]} 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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')]} 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:12 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:12 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 04:27:12 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 04:27:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:12 INFO - 'HOME': '/Users/cltbld', 04:27:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:12 INFO - 'LOGNAME': 'cltbld', 04:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:12 INFO - 'MOZ_NO_REMOTE': '1', 04:27:12 INFO - 'NO_EM_RESTART': '1', 04:27:12 INFO - 'PAGER': '/bin/cat', 04:27:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:12 INFO - 'PWD': '/builds/slave/test', 04:27:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:12 INFO - 'SHELL': '/bin/bash', 04:27:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:12 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:12 INFO - 'USER': 'cltbld', 04:27:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:12 INFO - 'XPC_FLAGS': '0x0', 04:27:12 INFO - 'XPC_SERVICE_NAME': '0', 04:27:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:12 INFO - Downloading/unpacking psutil>=3.1.1 04:27:12 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 04:27:12 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 04:27:12 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 04:27:12 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 04:27:12 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 04:27:12 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 04:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:16 INFO - Installing collected packages: psutil 04:27:16 INFO - Running setup.py install for psutil 04:27:16 INFO - building 'psutil._psutil_osx' extension 04:27:16 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 04:27:16 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 04:27:16 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 04:27:16 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 04:27:16 INFO - building 'psutil._psutil_posix' extension 04:27:16 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 04:27:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:27:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:27:17 INFO - ^ 04:27:17 INFO - 1 warning generated. 04:27:17 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 04:27:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:17 INFO - Successfully installed psutil 04:27:17 INFO - Cleaning up... 04:27:17 INFO - Return code: 0 04:27:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:17 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:17 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 04:27:17 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 04:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:17 INFO - 'HOME': '/Users/cltbld', 04:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:17 INFO - 'LOGNAME': 'cltbld', 04:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:17 INFO - 'MOZ_NO_REMOTE': '1', 04:27:17 INFO - 'NO_EM_RESTART': '1', 04:27:17 INFO - 'PAGER': '/bin/cat', 04:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:17 INFO - 'PWD': '/builds/slave/test', 04:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:17 INFO - 'SHELL': '/bin/bash', 04:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:17 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:17 INFO - 'USER': 'cltbld', 04:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:17 INFO - 'XPC_FLAGS': '0x0', 04:27:17 INFO - 'XPC_SERVICE_NAME': '0', 04:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:17 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 04:27:17 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 04:27:17 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 04:27:17 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 04:27:17 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 04:27:17 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 04:27:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:20 INFO - Installing collected packages: mozsystemmonitor 04:27:20 INFO - Running setup.py install for mozsystemmonitor 04:27:20 INFO - Successfully installed mozsystemmonitor 04:27:20 INFO - Cleaning up... 04:27:20 INFO - Return code: 0 04:27:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:20 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:20 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 04:27:20 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 04:27:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:20 INFO - 'HOME': '/Users/cltbld', 04:27:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:20 INFO - 'LOGNAME': 'cltbld', 04:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:20 INFO - 'MOZ_NO_REMOTE': '1', 04:27:20 INFO - 'NO_EM_RESTART': '1', 04:27:20 INFO - 'PAGER': '/bin/cat', 04:27:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:20 INFO - 'PWD': '/builds/slave/test', 04:27:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:20 INFO - 'SHELL': '/bin/bash', 04:27:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:20 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:20 INFO - 'USER': 'cltbld', 04:27:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:20 INFO - 'XPC_FLAGS': '0x0', 04:27:20 INFO - 'XPC_SERVICE_NAME': '0', 04:27:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:20 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:20 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 04:27:20 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 04:27:20 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 04:27:20 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 04:27:20 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 04:27:20 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 04:27:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:22 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 04:27:22 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 04:27:22 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 04:27:22 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 04:27:22 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 04:27:22 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 04:27:23 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:23 INFO - warning: no files found matching '*.txt' 04:27:23 INFO - no previously-included directories found matching 'build' 04:27:23 INFO - no previously-included directories found matching 'dist' 04:27:23 INFO - no previously-included directories found matching '.git*' 04:27:23 INFO - Installing collected packages: jsonschema, functools32 04:27:23 INFO - Running setup.py install for functools32 04:27:23 INFO - warning: no files found matching '*.txt' 04:27:23 INFO - no previously-included directories found matching 'build' 04:27:23 INFO - no previously-included directories found matching 'dist' 04:27:23 INFO - no previously-included directories found matching '.git*' 04:27:23 INFO - Successfully installed jsonschema functools32 04:27:23 INFO - Cleaning up... 04:27:23 INFO - Return code: 0 04:27:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:23 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:23 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 04:27:23 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 04:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:23 INFO - 'HOME': '/Users/cltbld', 04:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:23 INFO - 'LOGNAME': 'cltbld', 04:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:23 INFO - 'MOZ_NO_REMOTE': '1', 04:27:23 INFO - 'NO_EM_RESTART': '1', 04:27:23 INFO - 'PAGER': '/bin/cat', 04:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:23 INFO - 'PWD': '/builds/slave/test', 04:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:23 INFO - 'SHELL': '/bin/bash', 04:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:23 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:23 INFO - 'USER': 'cltbld', 04:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:23 INFO - 'XPC_FLAGS': '0x0', 04:27:23 INFO - 'XPC_SERVICE_NAME': '0', 04:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:27:23 INFO - Cleaning up... 04:27:23 INFO - Return code: 0 04:27:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:23 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:23 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 04:27:23 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 04:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:23 INFO - 'HOME': '/Users/cltbld', 04:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:23 INFO - 'LOGNAME': 'cltbld', 04:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:23 INFO - 'MOZ_NO_REMOTE': '1', 04:27:23 INFO - 'NO_EM_RESTART': '1', 04:27:23 INFO - 'PAGER': '/bin/cat', 04:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:23 INFO - 'PWD': '/builds/slave/test', 04:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:23 INFO - 'SHELL': '/bin/bash', 04:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:23 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:23 INFO - 'USER': 'cltbld', 04:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:23 INFO - 'XPC_FLAGS': '0x0', 04:27:23 INFO - 'XPC_SERVICE_NAME': '0', 04:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:24 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 04:27:24 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 04:27:24 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 04:27:24 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 04:27:24 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 04:27:24 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 04:27:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:27 INFO - Downloading docopt-0.6.1.tar.gz 04:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:27 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:27 INFO - Running setup.py install for blobuploader 04:27:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:28 INFO - Running setup.py install for requests 04:27:28 INFO - Running setup.py install for docopt 04:27:28 INFO - Successfully installed blobuploader requests docopt 04:27:28 INFO - Cleaning up... 04:27:28 INFO - Return code: 0 04:27:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:28 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:28 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 04:27:28 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 04:27:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:28 INFO - 'HOME': '/Users/cltbld', 04:27:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:28 INFO - 'LOGNAME': 'cltbld', 04:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:28 INFO - 'MOZ_NO_REMOTE': '1', 04:27:28 INFO - 'NO_EM_RESTART': '1', 04:27:28 INFO - 'PAGER': '/bin/cat', 04:27:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:28 INFO - 'PWD': '/builds/slave/test', 04:27:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:28 INFO - 'SHELL': '/bin/bash', 04:27:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:28 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:28 INFO - 'USER': 'cltbld', 04:27:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:28 INFO - 'XPC_FLAGS': '0x0', 04:27:28 INFO - 'XPC_SERVICE_NAME': '0', 04:27:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-KE6u60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Ac8a2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ab4kn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-yyMNkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Equ7CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-1oAAak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-X1pmv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-gHP10D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-M_CjkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-K3cxTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:30 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-63kb5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:30 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bEquNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:30 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bWVy4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:30 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-W9fV05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:30 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-N7QIK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:30 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-kY7PuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:30 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-gXhDRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:30 INFO - Running setup.py install for manifestparser 04:27:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Running setup.py install for mozcrash 04:27:31 INFO - Running setup.py install for mozdebug 04:27:31 INFO - Running setup.py install for mozdevice 04:27:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for mozfile 04:27:31 INFO - Running setup.py install for mozhttpd 04:27:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for mozinfo 04:27:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for mozInstall 04:27:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for mozleak 04:27:32 INFO - Running setup.py install for mozlog 04:27:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:32 INFO - Running setup.py install for moznetwork 04:27:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:32 INFO - Running setup.py install for mozprocess 04:27:32 INFO - Running setup.py install for mozprofile 04:27:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:32 INFO - Running setup.py install for mozrunner 04:27:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:32 INFO - Running setup.py install for mozscreenshot 04:27:33 INFO - Running setup.py install for moztest 04:27:33 INFO - Running setup.py install for mozversion 04:27:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:33 INFO - Cleaning up... 04:27:33 INFO - Return code: 0 04:27:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:33 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:33 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 04:27:33 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 04:27:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:33 INFO - 'HOME': '/Users/cltbld', 04:27:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:33 INFO - 'LOGNAME': 'cltbld', 04:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:33 INFO - 'MOZ_NO_REMOTE': '1', 04:27:33 INFO - 'NO_EM_RESTART': '1', 04:27:33 INFO - 'PAGER': '/bin/cat', 04:27:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:33 INFO - 'PWD': '/builds/slave/test', 04:27:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:33 INFO - 'SHELL': '/bin/bash', 04:27:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:33 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:33 INFO - 'USER': 'cltbld', 04:27:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:33 INFO - 'XPC_FLAGS': '0x0', 04:27:33 INFO - 'XPC_SERVICE_NAME': '0', 04:27:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-sGlp6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:33 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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ORBMfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:33 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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3RjCa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:33 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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pAR6db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ysYKIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_bnFTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-nNqRJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-IDzIVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-lXezMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-dU0vaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-LEK0fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-dFGm7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:34 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)) 04:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-zBrzNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:35 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)) 04:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:35 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-aDcq7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:35 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)) 04:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:35 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-IvVSTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:35 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)) 04:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:35 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bTGjO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:35 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)) 04:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:35 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_zOOen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:37 INFO - Downloading blessings-1.6.tar.gz 04:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:38 INFO - Installing collected packages: blessings 04:27:38 INFO - Running setup.py install for blessings 04:27:38 INFO - Successfully installed blessings 04:27:38 INFO - Cleaning up... 04:27:38 INFO - Return code: 0 04:27:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:38 INFO - Reading from file tmpfile_stdout 04:27:38 INFO - Current package versions: 04:27:38 INFO - blessings == 1.6 04:27:38 INFO - blobuploader == 1.2.4 04:27:38 INFO - docopt == 0.6.1 04:27:38 INFO - functools32 == 3.2.3-2 04:27:38 INFO - jsonschema == 2.5.1 04:27:38 INFO - manifestparser == 1.1 04:27:38 INFO - mozInstall == 1.12 04:27:38 INFO - mozcrash == 0.17 04:27:38 INFO - mozdebug == 0.1 04:27:38 INFO - mozdevice == 0.48 04:27:38 INFO - mozfile == 1.2 04:27:38 INFO - mozhttpd == 0.7 04:27:38 INFO - mozinfo == 0.9 04:27:38 INFO - mozleak == 0.1 04:27:38 INFO - mozlog == 3.3 04:27:38 INFO - moznetwork == 0.27 04:27:38 INFO - mozprocess == 0.23 04:27:38 INFO - mozprofile == 0.28 04:27:38 INFO - mozrunner == 6.12 04:27:38 INFO - mozscreenshot == 0.1 04:27:38 INFO - mozsystemmonitor == 0.3 04:27:38 INFO - moztest == 0.7 04:27:38 INFO - mozversion == 1.4 04:27:38 INFO - psutil == 3.1.1 04:27:38 INFO - requests == 1.2.3 04:27:38 INFO - wsgiref == 0.1.2 04:27:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:38 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 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27:38 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 04:27:38 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 04:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:38 INFO - 'HOME': '/Users/cltbld', 04:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:38 INFO - 'LOGNAME': 'cltbld', 04:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:38 INFO - 'MOZ_NO_REMOTE': '1', 04:27:38 INFO - 'NO_EM_RESTART': '1', 04:27:38 INFO - 'PAGER': '/bin/cat', 04:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:38 INFO - 'PWD': '/builds/slave/test', 04:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:38 INFO - 'SHELL': '/bin/bash', 04:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:38 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:38 INFO - 'USER': 'cltbld', 04:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:38 INFO - 'XPC_FLAGS': '0x0', 04:27:38 INFO - 'XPC_SERVICE_NAME': '0', 04:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 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)) 04:27:38 INFO - Cleaning up... 04:27:38 INFO - Return code: 0 04:27:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bfa48be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, '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.9lMzTxeEMX/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.NksRiTjbZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 04:27: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', 'jsonschema'] in /builds/slave/test/build 04:27: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 jsonschema 04:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:38 INFO - 'HOME': '/Users/cltbld', 04:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:38 INFO - 'LOGNAME': 'cltbld', 04:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:38 INFO - 'MOZ_NO_REMOTE': '1', 04:27:38 INFO - 'NO_EM_RESTART': '1', 04:27:38 INFO - 'PAGER': '/bin/cat', 04:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:38 INFO - 'PWD': '/builds/slave/test', 04:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:38 INFO - 'SHELL': '/bin/bash', 04:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:27:38 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:38 INFO - 'USER': 'cltbld', 04:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:38 INFO - 'XPC_FLAGS': '0x0', 04:27:38 INFO - 'XPC_SERVICE_NAME': '0', 04:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:39 INFO - Cleaning up... 04:27:39 INFO - Return code: 0 04:27:39 INFO - Running post-action listener: _resource_record_post_action 04:27:39 INFO - Running post-action listener: _start_resource_monitoring 04:27:39 INFO - Starting resource monitoring. 04:27:39 INFO - [mozharness: 2016-08-14 11:27:39.088812Z] Finished create-virtualenv step (success) 04:27:39 INFO - [mozharness: 2016-08-14 11:27:39.089842Z] Running install step. 04:27:39 INFO - Running pre-action listener: _resource_record_pre_action 04:27:39 INFO - Running main action method: install 04:27:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:39 INFO - Reading from file tmpfile_stdout 04:27:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:39 INFO - Reading from file tmpfile_stdout 04:27:39 INFO - Output received: 04:27:39 INFO - Usage: mozinstall [options] installer 04:27:39 INFO - Options: 04:27:39 INFO - -h, --help show this help message and exit 04:27:39 INFO - -d DEST, --destination=DEST 04:27:39 INFO - Directory to install application into. [default: 04:27:39 INFO - "/builds/slave/test"] 04:27:39 INFO - --app=APP Application being installed. [default: firefox] 04:27:39 INFO - mkdir: /builds/slave/test/build/application 04:27:39 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'] 04:27:39 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 04:28:13 INFO - Reading from file tmpfile_stdout 04:28:13 INFO - Output received: 04:28:13 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:28:13 INFO - Running post-action listener: _resource_record_post_action 04:28:13 INFO - [mozharness: 2016-08-14 11:28:13.468549Z] Finished install step (success) 04:28:13 INFO - [mozharness: 2016-08-14 11:28:13.468713Z] Running run-tests step. 04:28:13 INFO - Running pre-action listener: _resource_record_pre_action 04:28:13 INFO - Running main action method: run_tests 04:28:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:13 INFO - 2016-08-14 04:28:13.484 screenresolution[1683:16449] starting screenresolution argv=screenresolution get 04:28:13 INFO - 2016-08-14 04:28:13.487 screenresolution[1683:16449] Display 0: 1600x1200x32@60 04:28:13 INFO - 2016-08-14 04:28:13.493 screenresolution[1684:16452] starting screenresolution argv=screenresolution list 04:28:13 INFO - Available Modes on Display 0 04:28:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:13 INFO - Intel Iris: 04:28:13 INFO - Chipset Model: Intel Iris 04:28:13 INFO - Type: GPU 04:28:13 INFO - Bus: Built-In 04:28:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:13 INFO - Vendor: Intel (0x8086) 04:28:13 INFO - Device ID: 0x0a2e 04:28:13 INFO - Revision ID: 0x0009 04:28:13 INFO - Displays: 04:28:13 INFO - Display: 04:28:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:13 INFO - Display Serial Number: 1600x1200 60 04:28:13 INFO - Main Display: Yes 04:28:13 INFO - Mirror: Off 04:28:13 INFO - Online: Yes 04:28:13 INFO - Rotation: Supported 04:28:13 INFO - Return code: 0 04:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:13 INFO - Python 2.7.3 04:28:13 INFO - Return code: 0 04:28:13 INFO - grabbing minidump binary from tooltool 04:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:13 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 0x103b27d30>, '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 0x10388cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:13 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 04:28:13 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 04:28:13 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 04:28:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:13 INFO - Return code: 0 04:28:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:28:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:28:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 04:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --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 04:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9lMzTxeEMX/Render', 04:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:13 INFO - 'HOME': '/Users/cltbld', 04:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:13 INFO - 'LOGNAME': 'cltbld', 04:28:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:13 INFO - 'MOZ_NO_REMOTE': '1', 04:28:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:13 INFO - 'NO_EM_RESTART': '1', 04:28:13 INFO - 'PAGER': '/bin/cat', 04:28:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:13 INFO - 'PWD': '/builds/slave/test', 04:28:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:13 INFO - 'SHELL': '/bin/bash', 04:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NksRiTjbZR/Listeners', 04:28:13 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 04:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:13 INFO - 'USER': 'cltbld', 04:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:13 INFO - 'XPC_FLAGS': '0x0', 04:28:13 INFO - 'XPC_SERVICE_NAME': '0', 04:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 04:28:14 INFO - mozversion application_buildid: 20160814030203 04:28:14 INFO - mozversion application_changeset: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 04:28:14 INFO - mozversion application_display_name: Nightly 04:28:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:14 INFO - mozversion application_name: Firefox 04:28:14 INFO - mozversion application_remotingname: firefox 04:28:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:28:14 INFO - mozversion application_vendor: Mozilla 04:28:14 INFO - mozversion application_version: 51.0a1 04:28:14 INFO - mozversion platform_buildid: 20160814030203 04:28:14 INFO - mozversion platform_changeset: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 04:28:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:28:14 INFO - mozversion platform_version: 51.0a1 04:28:14 INFO - using testdate: 1471174094 04:28:14 INFO - actual date: 1471174094 04:28:14 INFO - starting webserver on 'localhost:49267' 04:28:14 INFO - SUITE-START | Running 2 tests 04:28:14 INFO - TEST-START | dromaeo_css 04:28:14 INFO - operating with platform_type : mac_ 04:28:14 INFO - Initialising browser for dromaeo_css test... 04:28:14 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpuc9CPu/profile http://localhost:49267/getInfo.html) 04:28:16 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 04:28:16 INFO - PROCESS | 1694 | colorDepth:24 04:28:16 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 04:28:16 INFO - PROCESS | 1694 | __metrics 04:28:16 INFO - PROCESS | 1694 | 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" 04:28:16 INFO - PROCESS | 1694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:17 INFO - TEST-INFO | 1694: exit 0 04:28:17 INFO - Browser initialized. 04:28:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:17 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpuc9CPu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:29 INFO - PROCESS | 1698 | RSS: Main: 228454400 04:28:29 INFO - PROCESS | 1698 | 04:29:21 INFO - PROCESS | 1698 | 1471174161287 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] 04:31:32 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 04:31:33 INFO - PROCESS | 1698 | RSS: Main: 359276544 04:31:33 INFO - PROCESS | 1698 | 04:34:37 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 04:34:37 INFO - PROCESS | 1698 | RSS: Main: 389468160 04:34:37 INFO - PROCESS | 1698 | 04:37:40 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 04:37:41 INFO - PROCESS | 1698 | RSS: Main: 337539072 04:37:41 INFO - PROCESS | 1698 | 04:40:43 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 04:40:44 INFO - PROCESS | 1698 | RSS: Main: 333651968 04:40:44 INFO - PROCESS | 1698 | 04:43:47 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 04:43:48 INFO - PROCESS | 1698 | RSS: Main: 333516800 04:43:48 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 04:46:51 INFO - PROCESS | 1698 | RSS: Main: 459804672 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | __start_tp_report 04:46:51 INFO - PROCESS | 1698 | _x_x_mozilla_page_load 04:46:51 INFO - PROCESS | 1698 | _x_x_mozilla_page_load_details 04:46:51 INFO - PROCESS | 1698 | |i|pagename|runs| 04:46:51 INFO - PROCESS | 1698 | |0;dojo.html;3186.9203269918253;3290.6051273847143;3327.68556420214;3331.583552055993;3333.6833000864926;5528.612997090206;5596.384397716253;5655.208270842086;5675;5697.6011679182475;5603.80386686466;5661.801836935698;5689.175069614904;5705.74324155413;5754.395788442216;5152.871178220537;5165.63840531163;5222.399424066224;5243.895122097556;5322.20166974953;4515.729056256619;5232.947670523303;5329.546988505962;5337.119375303089;5355;4154.750714957112;5172.870678233036;5176.611754118456;5226.843194704165;5294.6029047821185;5203.843884683465;5206.323177986876;5225.869353266161;5227.215917612389;5227.686338819683;5150.098732721759;5180.6891586504935;5213.895722085575;5217.8173763918085;5232.529072383466;5586.832395028156;5620.85947851307;5662.631928924607;5711.571632127566;5728.25532680753;6186.721597528077;6188.164597779287;6198.938010619881;6225.906611400787;6231.968840155816;6086.817395478142;6202.162708034448;6246.469050130744;6255.843603909893;6257.342978987186;5742.74157662902;5751.856203594902;5816.76732930678;5834.183214349994;5836.2412886325355;6217.253929528486;6220.471259942865;6237.875242495124;6252.781152659726;6255.499560035278;5960.344362120163;6194.845128871814;6197.504199664016;6202.906956395657;6216.720247588869;6077.87274453938;6154.323024467305;6155.199824022938;6179.5056395488255;6232.781852635227;6220.62676239418;6223.408776166257;6227.408396202444;6236.6258024518675;6242.313345531988;6207.162033125561;6253;6257.7184026718905;6266.373362663789;6270.372962703693;4837.95162048382;4881.804727810848;4924.162892308244;4926.113299606105;4963.205887058053;4404.097160082176;4404.6035856772405;4407.338899165086;4428.468583769968;4428.933565996513;5757.395473475309;5776.335721392094;5783.826485205451;5794.681292528867;5827.067669172912;6109.677964501087;6142.662153581507;6173.135760993465;6182.505399568024;6183.938160618336;5758.596898217084;5770.076787713946;5772.163036359789;5808.535317174616;5849.239598852122;5431.131019036935;5438.2386465894015;5439.428859969726;5443.482869127427;5447.754851031713;6181.443670069805;6222.688865556614;6235.532335074979;6257.561970662101;6277.811665650038;6318.368163183645;6321.683915804283;6323.9683801580695;6324.873502530016;6331.05034244867;6268.091126786681;6324.968375158095;6334.714937827901;6342.365763423621;6377.043443483514;6114.266288045463;6124.3809352984035;6131.713108457373;6135.294441139147;6219.720112595034;6265.15420418256;6268.561200715906;6269.028300613412;6276.9372306276355;6289.150964619717;5876.941230587639;6068.696565171812;6111.113888486234;6115.816525504242;6127.234095738033;5772.94227057724;5934.6142500737315;5955.464008239279;5964;6002.219711437485;5834.15404766298;5834.445727655866;5839.854003649943;5847.532197424111;5886.175935368966;6056.27299402718;6059.787907423219;6062.575619706578;6063.757449701962;6101.084837274267;5686.573506987075;5716.399778023414;5766.567507437043;5869.94130058711;5890.734916928663 04:46:51 INFO - PROCESS | 1698 | |1;ext.html;479.6187031310108;493.7901391908438;518.7250757098737;532.661759782538;533.128335171994;30534.54198187026;40963.79518102409;41513.37729934046;42077;44087.55912440875;43089.78455107728;43390.56609433905;43502.56497435024;43513.34729979045;43564.564354356444;8858.069902660225;9868.999999999982;9962.750931226705;9963.302568820185;9976.451295178762;8830.028696843374;11958.402079896014;12225.816612750816;12244.571439999601;12422.316772577504;12147.878521214763;12215.022798176169;12233.816492752616;12254.877451225462;12288.938555307255;8930.330225233134;12114.81827772584;12190.695232619168;12289.446974886107;12292.201006934522;11761.411929403495;12166.756664866742;12169.817452738216;12171.391430428443;12199.085068619888;40254;40327.7983610083;40561;40624;40730.38904416436;2890.624218851557;3188.852013275219;3328.3010567780793;3494.825258737053;3499.107727529464;31462.685373146203;31486;31670.89151879696;32090.518642220384;32627.51058734121;3116.4546204414364;3221.2108033531936;3253.268014696698;3265.8856940006985;3388.2207092368894;517370;522359;523377;526376;526645;60388.396116038275;60940;61042.38957610456;61117.38882611117;61175.69412152911;33930;34076.82961585176;34337.394573569414;35536.289274214374;35885.28229435449;16609.41867034648;16720.996740195627;16727.996320220584;16739.16304184786;16749.413770517975;11647.534098635959;11812.822807657893;12607.621771346874;12772.233665980071;12869.292188929512;18549;18839.529011774543;18863.339783107524;18939.81060189408;18943.62112757737;6270.6864656766975;7687.807804804925;7734.613269336511;7770.261825126604;7801.336886364723;700.4816435837444;732.8754111801006;870.7823044238941;1004.382304882492;1049.6011515624166;28745.712542874302;29996.700032999826;29997.250068748457;30758.92343768002;30811;1055.1031623120439;1081.4646749858714;1114.414932160606;1116.6650004998469;1123.43828085957;12867.871321286855;15700.607484812743;15880.444184453489;16190;17036.14819259032;682937;687442;688613;690024;691489;48330;59411;59447.405525945054;59456.40543594509;59489;1222.3093951917137;1275.4515558310015;1277.9872201278054;1369.5688006033718;1401.516476815497;22268.331950041524;27086.864565677835;31106.844465777525;31819;32396.190095246864;42726.57273427226;50166.74916625393;50335.496645034546;50343.49656503535;50448.49551504585;537659;542123.2893835505;542616;542953;543577;21642.24252151167;26977.3255668602;27264.454710906066;27363.315917101434;28511.28721781972;47256.054878901545;47501.76249118732;48134.27798582954;48233.75883120702;48296.75851620719;39097.41353879637;39375.80312098421;39556;39721.40417893676;40931.1813763729;39188.02029949274;39571.81284561468;39929.60070399259;40835.38746918739;41399.1720165589;38227.235455291295;39114.02214944535;39274.80362598169;39333.40999885061;39394.2121157581;29905.70094299029;32595;34659.30681386409;34859.82570087133;35014;24293.514129716954;25397.87301063483;25473.23580292594;26093.347666308495;26109 04:46:51 INFO - PROCESS | 1698 | |2;jquery.html;355.78475022611303;372.31122423516496;372.8005517048378;383.38083994349137;405.9951619741141;15865.84134158658;15911.28399222035;17591.472255832312;19093.904530477364;20548.178072877086;20535.794642053574;21140;21226.83252421116;21324.893375533138;21562.814045227507;5833.416658334154;5936.643801371932;6036.607620504675;6211.565190436671;6219.875602487948;4193.643540299078;6009.399060094;6106.664133472657;6108.389161083878;6120.81637550872;6402.519811014193;6722.495812814059;6744.2244141923575;6788.762393316235;6804.353586409308;6599.835004124887;6698.263191048981;6727.293634168391;6767.390934815866;6809.761658341934;5808.88382232353;5838.7080645967535;5841.678707671076;5854.824355269348;5859.4140585941495;24148.517029659484;24605.261842144766;25100;25251.873740631177;25432.728363581748;2116.216999710102;2198.7801219877883;2204.1164678562136;2366.2782851230368;2554.6040363743464;8296.626651800623;10284.794304113952;10391.792164156675;16399.508014759576;16808.663826723398;1942.4464027752165;1966.7049942508595;1968.7243785869846;2026.5440275937945;2088.1960445228547;109870.90129098686;113774;131888.3405582966;131960;141215;14495.042468451009;20344;20634;20808.687869681966;21072;34383;34433.483497747555;34522.48216276758;34624.307513849584;34628.30743385118;10370.429626370622;10761.730956726144;10948;10953.890461095287;11131.551058767058;7327.413806895435;8982.326325525612;9037.50293733851;9144.679936202201;9166.26669866409;9337.159655631025;9519.286053545873;9559.808803823884;9672.95163524178;9677.274204434696;3570.1967057411875;3648.3980143276594;3648.8175591220333;3660.5058317126845;3669.2661467706566;839.6515446089926;847.0513025411578;858.8234119256658;880.6741505642825;943.834828904939;19993.400197994084;21076.367708968755;21876.562468750853;21946.231881884058;21983.34049978503;910.6266430763355;926.6617684545092;929.9628014879464;949.5299826585746;967.6129548180784;10311.84532232017;10645.254832161674;10839.024487795978;11571.01646360052;11589.826152607717;602562;610071;618296;620792;622932;130309.04536431961;131035.34482327718;131545.68454315525;132271.3545729099;134040.32979835037;872.9039805621377;914.5427286356821;947.5404428852002;981.8919918809069;983.2772911909883;19794.60410791805;20155.899220503805;20357.287494937606;20361.79638203599;20373.879436630534;55151.17273240985;55922.44077559172;56261.718691406284;56512.71743641255;57397.71301143467;74549.13627159147;76965.2303476958;82058.9220455231;87191;88893.11106889107;7851.528908265523;7967.4060660932455;8012.679492820222;8353.415260931919;8504.659813607386;11503.367314797766;12714.61856144317;12892.226466412045;13092.607221783363;13429.194248345131;10504.474776261004;11346.659600212008;11552.191346605992;11562.537498499965;11647.30116193031;10751.408672523086;11080.39057851826;11340.979311861973;11374.54501819918;11669.474873630877;11145.554177832795;11257.605983790529;11716.472758725708;11813.704657383634;11881.405929703307;7572.924270757222;8247.628856701343;8284.295834854105;8353.0811610724;8377.947402886331;10188.89811101909;11072.723181920517;11312.547498100314;11316.830247546459;11410.82883756761 04:46:51 INFO - PROCESS | 1698 | |3;mootools.html;1533.1567637799212;1558.3844381469316;1723.7931448226216;1850.3986204483547;1863.972040419394;8508.914910850897;9101.998780134196;9107.358865928889;9110.043445438232;9112.726618201455;7933.920660793405;8190.344772418207;8620.784480387994;8834.867476987834;8872.911270887289;2319.652052192172;2342.0397636968846;2351.776581224781;2354.5173239485866;2359.327591636384;2315.4211447138214;2318.3624503261653;2382.106709983756;2387.7015373078366;2392;1727.697652910742;2076.3874656976154;2157.5145592241697;2158.816500597451;2161.6433288507455;2281.954360912781;2364.728056273533;2367.633016882386;2371.5968285391523;2380.9523809523885;1913.7799153097433;2333.241696448661;2339.1462116327416;2339.4853132310864;2341.7424083350816;8869.467831930106;9047.728568142966;9064.957529884015;9073.047330030318;9081.318901082379;5275.155975043975;5428.430014848463;5429.53848922842;5440.510354068113;5446.945530544684;3587.8600425285185;3688.3729765939856;3747.306748251582;3748.4939533162947;3762.322781899257;1079.94060326682;1118.2619471149003;1129.5764088466824;1146.9369184694838;1148.1847887999531;11992.820107698391;12021.639350819489;12030.278183308941;12060.638180854588;12070.215435996632;4616.930746038812;4641.18779213643;4819.7108173509005;4872.171730805771;4872.975635121802;10109.140723038625;10115.44365059914;10130.189584833195;10133.442660653587;10152.39085654863;5410.053240682943;5411.783528658888;5427.375851777097;5427.43011983744;5436.477786219864;4760.64295177863;4901.142300097468;4952.232403977389;4973.577245934064;4992.750362481861;3936.488256526633;3962.8018599069933;4042.2521833460905;4093;4105.609967053125;1270.720441502868;1292.7931530955002;1294.643972907439;1310.8754668306497;1310.9803352949714;859.6733241368365;868.5440143924363;873.8116162019649;920.521328908977;952.3761935931838;4455.977720111444;5064.012517559041;5805.274340707411;5887.735051922674;6179.073139029092;427.890887823603;430.12898879768096;434.97390156590706;435.3274191374271;452.1747810246248;3824.3116239076676;3874.2638898609175;3994.900127496836;4025.2352053109817;4074.388841673713;10529;10923.508442120125;10924.2899211551;10937.890621093688;10947.069499092508;10857;10867.45662716861;10891.965263299973;11012.944935275273;11071.05895998833;8019.198080191934;8121.715739949073;8239.917600824036;8284.25441710237;8334.749957501284;5917.615355001911;5935.851603709942;5936.5455463411745;6013.579049466671;6025.307089684742;9830.4101753895;10207.132393746615;10256.743581410525;10262.743431413975;10294.3823370595;7044.8591028178125;10211.540480678239;10216.438095904796;10233.692989210336;10371.429571373646;7610.124835643972;7743.45795794289;7751.496152750054;7756.92243077562;7761.107472640493;8239.093699693149;8341.66633334684;8420.621072051896;8443.704470343508;8454.704085356983;7487.401007919245;7640.426967977312;7657.961710191414;7679.616019198906;7761.4178936578855;6385.233771947396;7308.744193953186;7416.7033318666645;7433.405327573889;7581.50720203185;6183.412575805291;7048.436125110082;7066.681999310146;7068.5758854468895;7157.105361829771;4318.78406079701;5040.16837221869;5058.797648094035;5079.009593129304;5194.4805519447755;5029.84910452687;5118.769655365443;5153.123968925217;5231.738413079407;5324.414314425488 04:46:51 INFO - PROCESS | 1698 | |4;prototype.html;248.975102489751;305.5783019433182;308.4001616855216;312.35031135238694;318.4474935986065;4506.23394023016;5115.5651769599535;5282.151247063526;5299.867503312409;5329.227262047001;3949.9802500987453;5238.607104467161;5239.004589128063;5282.128448805952;5306.124489459235;3114.2594516825275;3856.633619806114;3974.3839704845795;4019.934717299918;4030.435738996543;3473.791572505645;3786.129190286236;4024.7182697211206;4059.391091336294;4061.756294622332;3966.3455529837543;3985.2464915437113;3989.6209860063245;3998.3002974479496;4003.5596084430836;3066.4480393529043;3850.190410507057;3862.8841134766003;3867.207222519377;4034.213328400963;2942.073246927211;3481.89554313371;3506.4740288956605;3507.736919731005;3509.210427653783;4473.418455600751;5128.897422051576;5150.716710580917;5180.021487644582;5185.740712964337;4551.772411379451;4656.813727450898;4657.860264192046;4660.300954856764;4699.600533954618;5083.796648134107;5538.861528461781;5560.833175004756;5588.050031494656;5606.439356064361;3224.790388624732;3904.754766009556;3910.667593254577;3923.8609112710005;3934.976906004431;4740.620750340034;5694.889496548175;5798.9420105799245;5963.731632076567;5966.522678185735;3895.331697787025;3913.491246137984;3931.9017024574614;3932.9745181231115;3950.4395763673188;3993.2412841560013;4000.5195479932645;4009.719319647655;4031.697622678311;4041.6968727345566;4597.963517992849;4642.303654451859;4661.067786442725;4692.732962100214;4692.976535117303;4379.321205213197;5474.562035037187;5534.4742249486235;5604.3835178130375;5629.832514481954;1270.8157317188957;1279.1835593457313;1360.4558176729388;1380.3995262061035;1396.0227840511682;794.4161041634394;843.0220943705273;849.907868389117;854.1501206299771;858.6176256227469;3946.723729338919;4188.308929026737;4351.455233392164;4860.392450943632;5145.536901678867;5014;5628.577856660685;5760.251167348218;5779.88440231193;5798.362180160179;5167.785570390955;5174.66234278888;5182.818601348935;5190.351206099238;5197.688138711689;2387.8180300751237;2711.4848178845955;2975.6577993530586;3044.3911217756536;3050.4661684205175;5210.505002024802;5942.4150494535015;6005.789797357159;6012.098185272244;6051.062085376773;5002.199648056294;5078.492150784892;5459.2629994950175;5634.887302254014;5979.372165922602;5073.974630126826;5995.820125396245;6053.303870054824;6076.574639775174;6152;4552.6813123081065;5522.923030009109;5542.806001789918;5764.625299355528;5850.180974663635;4782.808687652594;5569.020573992894;5763.73483622125;5778.248827652546;5793.9581719597545;5650.26546548946;5995.5803093783015;6031.487323577545;6044.274687037584;6112.724927378367;3008.714172153642;3340.983295083606;3916.5508761758333;3964.583718709494;4017.5536806750133;4120.979395103005;5632.971835140798;5789.2763404574425;5794.101914203306;5811.314718731521;5142.562882154909;5611.607187496836;5671;5671.865626874559;5678.801241956677;4586.945002649342;4837.612990960644;5558.249636299048;5656.179853921076;5656.830295091154;4569.81720731167;5320.707361095177;5332.70670113132;5569.55443564522;5577.330720313588;4879.365682461257;5334.106102545241;5538.529225015919;5646.830595082154;5667.296144200386;4416.4258646375765;5060.861306206074;5423.159410291411;5432.456754324536;5446.840832317325 04:46:51 INFO - PROCESS | 1698 | |5;yui.html;697.884848999915;733.9211359301825;775.1473379282786;813.812823050698;851.6976473351962;14804.851951480481;15407.69184616307;16107.83892161078;16138.596535086628;16335.59161020975;14696.632584185374;14770.335334909929;14920.626984325398;14957.551273461786;15077.849221507782;690.492488021304;843.6667516331046;863.7322430046705;864.3776480933718;865.7186414415308;702.0942983551213;827.8054657155564;846.4413487098516;854.1117238072397;856.2379482260793;908.8636704494313;908.9772755681095;912.3886995712888;912.9497877616728;913.9497327646977;712.9536580122327;904.2268860124631;906.0576999920075;906.4334790755778;909.7589138878136;651.882661120998;668.1180841289499;669.100060418736;669.243754557352;676.2730065179951;14745.631359215999;14788.630284242872;14798;14800.259987000607;14805.03767255125;13602.659933501644;13937;14021.5092471763;14024.859751402457;14183.929080354636;12684.682882927907;12748;12835.229886206858;12953.740925181537;13014.674633134153;4487.708298960557;4491.573300536444;4533.365328853963;4580;4616.561426664462;114993.85006149915;115398;115894;116743;116840.41579792132;10703.892961070445;10938.945305273583;11264.26782259167;11317.434128293553;11563.132765042656;21319;21352.466188345104;21378.679319810217;21388.572228555342;21392.679109813365;7787.260210280015;7911.050673919167;7983.640736166886;8078.071021832447;8093.19068093186;4261.446012018479;4321.092570560155;4412.823487060482;4465.0623369092855;4483.21543729846;3436.639152888961;3545.2554963457965;3549.503069570262;3549.574051113883;3560.643935606419;572.584875964922;681.1451628206668;707.4411215140085;717.3328804212133;738.0073800737999;554.2711334594994;585.2450339062561;671.6037537852691;690.6098054599236;694.8992396102536;9223.492707900996;9577;9912.55393507294;9922;9957.253206009578;538.8625900395374;566.6373520946597;583.2971269620098;592.6177615438019;656.3108735827362;4258.233517966796;4738.8341408050555;4762.9521505268785;4790.5448982346625;4814.825820382479;120889;161961;167400;169400;177373;136274.3186284062;138965;141829.99999999793;145221.27389362987;146889;98630;102258.48870755748;103888;105443.41834872484;105959.47020264849;9801.11789938909;10044;10106.949465252626;10190.643327483502;10215.693529194135;57808.1328780077;58373.416265838496;60778.39221607727;62335.06497402452;62887.17007734571;71653.92519112321;75794.24205758092;89914.55042724745;93354.53322733344;96043;13424.194548327132;13629.250391228577;13636.113652612548;13809.585712428643;14145.717085658434;14732.189729564976;15139.772903406678;15294.46469373611;15614;15673.216339182767;13931.094478858842;14143.434262629791;14146.858531414555;14368.928155359155;14433.422663093359;11197.552097915992;13807.792883106962;14248.786268205778;14253.073550219202;14277;13735.064110197896;13913;13920.58238252854;13996.16023038621;14320.283985800459;11153.609623663133;11312.20814543007;11651.242669226473;11661.24201926872;12011.939940300243;10720.678379648623;10752.623658171926;11488.36813975206;11680.824787628362;11692.88307116952 04:46:51 INFO - PROCESS | 1698 | __end_tp_report 04:46:51 INFO - PROCESS | 1698 | __start_cc_report 04:46:51 INFO - PROCESS | 1698 | _x_x_mozilla_cycle_collect,1274 04:46:51 INFO - PROCESS | 1698 | __end_cc_report 04:46:51 INFO - PROCESS | 1698 | __startTimestamp1471175211864__endTimestamp 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | ------- Summary: start ------- 04:46:51 INFO - PROCESS | 1698 | Number of tests: 6 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | [#0] dojo.html Cycles:165 Average:5721.44 Median:5849.24 stddev:652.44 (11.2%) stddev-sans-first:623.41 04:46:51 INFO - PROCESS | 1698 | Values: 3186.9 3290.6 3327.7 3331.6 3333.7 5528.6 5596.4 5655.2 5675.0 5697.6 5603.8 5661.8 5689.2 5705.7 5754.4 5152.9 5165.6 5222.4 5243.9 5322.2 4515.7 5232.9 5329.5 5337.1 5355.0 4154.8 5172.9 5176.6 5226.8 5294.6 5203.8 5206.3 5225.9 5227.2 5227.7 5150.1 5180.7 5213.9 5217.8 5232.5 5586.8 5620.9 5662.6 5711.6 5728.3 6186.7 6188.2 6198.9 6225.9 6232.0 6086.8 6202.2 6246.5 6255.8 6257.3 5742.7 5751.9 5816.8 5834.2 5836.2 6217.3 6220.5 6237.9 6252.8 6255.5 5960.3 6194.8 6197.5 6202.9 6216.7 6077.9 6154.3 6155.2 6179.5 6232.8 6220.6 6223.4 6227.4 6236.6 6242.3 6207.2 6253.0 6257.7 6266.4 6270.4 4838.0 4881.8 4924.2 4926.1 4963.2 4404.1 4404.6 4407.3 4428.5 4428.9 5757.4 5776.3 5783.8 5794.7 5827.1 6109.7 6142.7 6173.1 6182.5 6183.9 5758.6 5770.1 5772.2 5808.5 5849.2 5431.1 5438.2 5439.4 5443.5 5447.8 6181.4 6222.7 6235.5 6257.6 6277.8 6318.4 6321.7 6324.0 6324.9 6331.1 6268.1 6325.0 6334.7 6342.4 6377.0 6114.3 6124.4 6131.7 6135.3 6219.7 6265.2 6268.6 6269.0 6276.9 6289.2 5876.9 6068.7 6111.1 6115.8 6127.2 5772.9 5934.6 5955.5 5964.0 6002.2 5834.2 5834.4 5839.9 5847.5 5886.2 6056.3 6059.8 6062.6 6063.8 6101.1 5686.6 5716.4 5766.6 5869.9 5890.7 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | [#1] ext.html Cycles:180 Average:71107.80 Median:19177.33 stddev:157542.71 (821.5%) stddev-sans-first:157895.41 04:46:51 INFO - PROCESS | 1698 | Values: 479.6 493.8 518.7 532.7 533.1 30534.5 40963.8 41513.4 42077.0 44087.6 43089.8 43390.6 43502.6 43513.3 43564.6 8858.1 9869.0 9962.8 9963.3 9976.5 8830.0 11958.4 12225.8 12244.6 12422.3 12147.9 12215.0 12233.8 12254.9 12288.9 8930.3 12114.8 12190.7 12289.4 12292.2 11761.4 12166.8 12169.8 12171.4 12199.1 40254.0 40327.8 40561.0 40624.0 40730.4 2890.6 3188.9 3328.3 3494.8 3499.1 31462.7 31486.0 31670.9 32090.5 32627.5 3116.5 3221.2 3253.3 3265.9 3388.2 517370.0 522359.0 523377.0 526376.0 526645.0 60388.4 60940.0 61042.4 61117.4 61175.7 33930.0 34076.8 34337.4 35536.3 35885.3 16609.4 16721.0 16728.0 16739.2 16749.4 11647.5 11812.8 12607.6 12772.2 12869.3 18549.0 18839.5 18863.3 18939.8 18943.6 6270.7 7687.8 7734.6 7770.3 7801.3 700.5 732.9 870.8 1004.4 1049.6 28745.7 29996.7 29997.3 30758.9 30811.0 1055.1 1081.5 1114.4 1116.7 1123.4 12867.9 15700.6 15880.4 16190.0 17036.1 682937.0 687442.0 688613.0 690024.0 691489.0 48330.0 59411.0 59447.4 59456.4 59489.0 1222.3 1275.5 1278.0 1369.6 1401.5 22268.3 27086.9 31106.8 31819.0 32396.2 42726.6 50166.7 50335.5 50343.5 50448.5 537659.0 542123.3 542616.0 542953.0 543577.0 21642.2 26977.3 27264.5 27363.3 28511.3 47256.1 47501.8 48134.3 48233.8 48296.8 39097.4 39375.8 39556.0 39721.4 40931.2 39188.0 39571.8 39929.6 40835.4 41399.2 38227.2 39114.0 39274.8 39333.4 39394.2 29905.7 32595.0 34659.3 34859.8 35014.0 24293.5 25397.9 25473.2 26093.3 26109.0 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | [#2] jquery.html Cycles:180 Average:37193.46 Median:34477.98 stddev:102629.08 (297.7%) stddev-sans-first:102879.70 04:46:51 INFO - PROCESS | 1698 | Values: 355.8 372.3 372.8 383.4 406.0 15865.8 15911.3 17591.5 19093.9 20548.2 20535.8 21140.0 21226.8 21324.9 21562.8 5833.4 5936.6 6036.6 6211.6 6219.9 4193.6 6009.4 6106.7 6108.4 6120.8 6402.5 6722.5 6744.2 6788.8 6804.4 6599.8 6698.3 6727.3 6767.4 6809.8 5808.9 5838.7 5841.7 5854.8 5859.4 24148.5 24605.3 25100.0 25251.9 25432.7 2116.2 2198.8 2204.1 2366.3 2554.6 8296.6 10284.8 10391.8 16399.5 16808.7 1942.4 1966.7 1968.7 2026.5 2088.2 109870.9 113774.0 131888.3 131960.0 141215.0 14495.0 20344.0 20634.0 20808.7 21072.0 34383.0 34433.5 34522.5 34624.3 34628.3 10370.4 10761.7 10948.0 10953.9 11131.6 7327.4 8982.3 9037.5 9144.7 9166.3 9337.2 9519.3 9559.8 9673.0 9677.3 3570.2 3648.4 3648.8 3660.5 3669.3 839.7 847.1 858.8 880.7 943.8 19993.4 21076.4 21876.6 21946.2 21983.3 910.6 926.7 930.0 949.5 967.6 10311.8 10645.3 10839.0 11571.0 11589.8 602562.0 610071.0 618296.0 620792.0 622932.0 130309.0 131035.3 131545.7 132271.4 134040.3 872.9 914.5 947.5 981.9 983.3 19794.6 20155.9 20357.3 20361.8 20373.9 55151.2 55922.4 56261.7 56512.7 57397.7 74549.1 76965.2 82058.9 87191.0 88893.1 7851.5 7967.4 8012.7 8353.4 8504.7 11503.4 12714.6 12892.2 13092.6 13429.2 10504.5 11346.7 11552.2 11562.5 11647.3 10751.4 11080.4 11341.0 11374.5 11669.5 11145.6 11257.6 11716.5 11813.7 11881.4 7572.9 8247.6 8284.3 8353.1 8377.9 10188.9 11072.7 11312.5 11316.8 11410.8 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | [#3] mootools.html Cycles:180 Average:5747.44 Median:4629.06 stddev:3279.03 (70.8%) stddev-sans-first:3272.94 04:46:51 INFO - PROCESS | 1698 | Values: 1533.2 1558.4 1723.8 1850.4 1864.0 8508.9 9102.0 9107.4 9110.0 9112.7 7933.9 8190.3 8620.8 8834.9 8872.9 2319.7 2342.0 2351.8 2354.5 2359.3 2315.4 2318.4 2382.1 2387.7 2392.0 1727.7 2076.4 2157.5 2158.8 2161.6 2282.0 2364.7 2367.6 2371.6 2381.0 1913.8 2333.2 2339.1 2339.5 2341.7 8869.5 9047.7 9065.0 9073.0 9081.3 5275.2 5428.4 5429.5 5440.5 5446.9 3587.9 3688.4 3747.3 3748.5 3762.3 1079.9 1118.3 1129.6 1146.9 1148.2 11992.8 12021.6 12030.3 12060.6 12070.2 4616.9 4641.2 4819.7 4872.2 4873.0 10109.1 10115.4 10130.2 10133.4 10152.4 5410.1 5411.8 5427.4 5427.4 5436.5 4760.6 4901.1 4952.2 4973.6 4992.8 3936.5 3962.8 4042.3 4093.0 4105.6 1270.7 1292.8 1294.6 1310.9 1311.0 859.7 868.5 873.8 920.5 952.4 4456.0 5064.0 5805.3 5887.7 6179.1 427.9 430.1 435.0 435.3 452.2 3824.3 3874.3 3994.9 4025.2 4074.4 10529.0 10923.5 10924.3 10937.9 10947.1 10857.0 10867.5 10892.0 11012.9 11071.1 8019.2 8121.7 8239.9 8284.3 8334.7 5917.6 5935.9 5936.5 6013.6 6025.3 9830.4 10207.1 10256.7 10262.7 10294.4 7044.9 10211.5 10216.4 10233.7 10371.4 7610.1 7743.5 7751.5 7756.9 7761.1 8239.1 8341.7 8420.6 8443.7 8454.7 7487.4 7640.4 7658.0 7679.6 7761.4 6385.2 7308.7 7416.7 7433.4 7581.5 6183.4 7048.4 7066.7 7068.6 7157.1 4318.8 5040.2 5058.8 5079.0 5194.5 5029.8 5118.8 5153.1 5231.7 5324.4 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | [#4] prototype.html Cycles:180 Average:4494.58 Median:5076.23 stddev:1407.35 (27.7%) stddev-sans-first:1374.74 04:46:51 INFO - PROCESS | 1698 | Values: 249.0 305.6 308.4 312.4 318.4 4506.2 5115.6 5282.2 5299.9 5329.2 3950.0 5238.6 5239.0 5282.1 5306.1 3114.3 3856.6 3974.4 4019.9 4030.4 3473.8 3786.1 4024.7 4059.4 4061.8 3966.3 3985.2 3989.6 3998.3 4003.6 3066.4 3850.2 3862.9 3867.2 4034.2 2942.1 3481.9 3506.5 3507.7 3509.2 4473.4 5128.9 5150.7 5180.0 5185.7 4551.8 4656.8 4657.9 4660.3 4699.6 5083.8 5538.9 5560.8 5588.1 5606.4 3224.8 3904.8 3910.7 3923.9 3935.0 4740.6 5694.9 5798.9 5963.7 5966.5 3895.3 3913.5 3931.9 3933.0 3950.4 3993.2 4000.5 4009.7 4031.7 4041.7 4598.0 4642.3 4661.1 4692.7 4693.0 4379.3 5474.6 5534.5 5604.4 5629.8 1270.8 1279.2 1360.5 1380.4 1396.0 794.4 843.0 849.9 854.2 858.6 3946.7 4188.3 4351.5 4860.4 5145.5 5014.0 5628.6 5760.3 5779.9 5798.4 5167.8 5174.7 5182.8 5190.4 5197.7 2387.8 2711.5 2975.7 3044.4 3050.5 5210.5 5942.4 6005.8 6012.1 6051.1 5002.2 5078.5 5459.3 5634.9 5979.4 5074.0 5995.8 6053.3 6076.6 6152.0 4552.7 5522.9 5542.8 5764.6 5850.2 4782.8 5569.0 5763.7 5778.2 5794.0 5650.3 5995.6 6031.5 6044.3 6112.7 3008.7 3341.0 3916.6 3964.6 4017.6 4121.0 5633.0 5789.3 5794.1 5811.3 5142.6 5611.6 5671.0 5671.9 5678.8 4586.9 4837.6 5558.2 5656.2 5656.8 4569.8 5320.7 5332.7 5569.6 5577.3 4879.4 5334.1 5538.5 5646.8 5667.3 4416.4 5060.9 5423.2 5432.5 5446.8 04:46:51 INFO - PROCESS | 1698 | 04:46:51 INFO - PROCESS | 1698 | [#5] yui.html Cycles:180 Average:25451.25 Median:21383.63 stddev:41280.21 (193.0%) stddev-sans-first:41354.17 04:46:51 INFO - PROCESS | 1698 | Values: 697.9 733.9 775.1 813.8 851.7 14804.9 15407.7 16107.8 16138.6 16335.6 14696.6 14770.3 14920.6 14957.6 15077.8 690.5 843.7 863.7 864.4 865.7 702.1 827.8 846.4 854.1 856.2 908.9 909.0 912.4 912.9 913.9 713.0 904.2 906.1 906.4 909.8 651.9 668.1 669.1 669.2 676.3 14745.6 14788.6 14798.0 14800.3 14805.0 13602.7 13937.0 14021.5 14024.9 14183.9 12684.7 12748.0 12835.2 12953.7 13014.7 4487.7 4491.6 4533.4 4580.0 4616.6 114993.9 115398.0 115894.0 116743.0 116840.4 10703.9 10938.9 11264.3 11317.4 11563.1 21319.0 21352.5 21378.7 21388.6 21392.7 7787.3 7911.1 7983.6 8078.1 8093.2 4261.4 4321.1 4412.8 4465.1 4483.2 3436.6 3545.3 3549.5 3549.6 3560.6 572.6 681.1 707.4 717.3 738.0 554.3 585.2 671.6 690.6 694.9 9223.5 9577.0 9912.6 9922.0 9957.3 538.9 566.6 583.3 592.6 656.3 4258.2 4738.8 4763.0 4790.5 4814.8 120889.0 161961.0 167400.0 169400.0 177373.0 136274.3 138965.0 141830.0 145221.3 146889.0 98630.0 102258.5 103888.0 105443.4 105959.5 9801.1 10044.0 10106.9 10190.6 10215.7 57808.1 58373.4 60778.4 62335.1 62887.2 71653.9 75794.2 89914.6 93354.5 96043.0 13424.2 13629.3 13636.1 13809.6 14145.7 14732.2 15139.8 15294.5 15614.0 15673.2 13931.1 14143.4 14146.9 14368.9 14433.4 11197.6 13807.8 14248.8 14253.1 14277.0 13735.1 13913.0 13920.6 13996.2 14320.3 11153.6 11312.2 11651.2 11661.2 12011.9 10720.7 10752.6 11488.4 11680.8 11692.9 04:46:51 INFO - PROCESS | 1698 | -------- Summary: end -------- 04:46:51 INFO - PROCESS | 1698 | 04:46:52 INFO - TEST-INFO | 1698: exit 0 04:46:52 INFO - TEST-OK | dromaeo_css | took 1118394ms 04:46:52 INFO - TEST-START | kraken 04:46:52 INFO - operating with platform_type : mac_ 04:46:52 INFO - Initialising browser for kraken test... 04:46:52 INFO - TEST-INFO | started process 1704 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpyHFKuA/profile http://localhost:49267/getInfo.html) 04:46:54 INFO - PROCESS | 1704 | __metrics Screen width/height:1600/1200 04:46:54 INFO - PROCESS | 1704 | colorDepth:24 04:46:54 INFO - PROCESS | 1704 | Browser inner width/height: 1024/689 04:46:54 INFO - PROCESS | 1704 | __metrics 04:46:54 INFO - PROCESS | 1704 | 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" 04:46:54 INFO - PROCESS | 1704 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:55 INFO - TEST-INFO | 1704: exit 0 04:46:55 INFO - Browser initialized. 04:46:55 INFO - Running cycle 1/1 for kraken test... 04:46:55 INFO - TEST-INFO | started process 1706 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpyHFKuA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:07 INFO - PROCESS | 1706 | RSS: Main: 228372480 04:47:07 INFO - PROCESS | 1706 | 04:47:10 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:11 INFO - PROCESS | 1706 | RSS: Main: 285298688 04:47:11 INFO - PROCESS | 1706 | 04:47:13 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 04:47:14 INFO - PROCESS | 1706 | RSS: Main: 295645184 04:47:14 INFO - PROCESS | 1706 | 04:47:17 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 04:47:18 INFO - PROCESS | 1706 | RSS: Main: 387837952 04:47:18 INFO - PROCESS | 1706 | 04:47:20 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 04:47:21 INFO - PROCESS | 1706 | RSS: Main: 289595392 04:47:21 INFO - PROCESS | 1706 | 04:47:23 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:23 INFO - PROCESS | 1706 | RSS: Main: 295510016 04:47:23 INFO - PROCESS | 1706 | 04:47:26 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:27 INFO - PROCESS | 1706 | RSS: Main: 330788864 04:47:27 INFO - PROCESS | 1706 | 04:47:30 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:30 INFO - PROCESS | 1706 | RSS: Main: 333602816 04:47:30 INFO - PROCESS | 1706 | 04:47:33 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 04:47:34 INFO - PROCESS | 1706 | RSS: Main: 333918208 04:47:34 INFO - PROCESS | 1706 | 04:47:35 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:36 INFO - PROCESS | 1706 | RSS: Main: 301297664 04:47:36 INFO - PROCESS | 1706 | 04:47:38 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:38 INFO - PROCESS | 1706 | RSS: Main: 307703808 04:47:38 INFO - PROCESS | 1706 | 04:47:40 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:41 INFO - PROCESS | 1706 | RSS: Main: 303542272 04:47:41 INFO - PROCESS | 1706 | 04:47:44 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:45 INFO - PROCESS | 1706 | RSS: Main: 314310656 04:47:45 INFO - PROCESS | 1706 | 04:47:48 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:48 INFO - PROCESS | 1706 | RSS: Main: 316719104 04:47:48 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 04:47:50 INFO - PROCESS | 1706 | RSS: Main: 360415232 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | __start_tp_report 04:47:50 INFO - PROCESS | 1706 | _x_x_mozilla_page_load 04:47:50 INFO - PROCESS | 1706 | _x_x_mozilla_page_load_details 04:47:50 INFO - PROCESS | 1706 | |i|pagename|runs| 04:47:50 INFO - PROCESS | 1706 | |0;ai-astar;103;113;114;114;108;113;112;114;113;114 04:47:50 INFO - PROCESS | 1706 | |1;audio-beat-detection;143;105;108;163;105;103;157;138;180;108 04:47:50 INFO - PROCESS | 1706 | |2;audio-dft;183;187;186;186;184;184;178;183;182;182 04:47:50 INFO - PROCESS | 1706 | |3;audio-fft;80;58;59;84;58;57;64;64;84;57 04:47:50 INFO - PROCESS | 1706 | |4;audio-oscillator;90;69;107;71;73;69;95;71;68;101 04:47:50 INFO - PROCESS | 1706 | |5;imaging-gaussian-blur;89;84;87;86;87;86;89;84;88;87 04:47:50 INFO - PROCESS | 1706 | |6;imaging-darkroom;93;93;94;94;93;93;101;122;130;94 04:47:50 INFO - PROCESS | 1706 | |7;imaging-desaturate;85;85;84;86;85;83;86;85;84;83 04:47:50 INFO - PROCESS | 1706 | |8;json-parse-financial;57;55;56;56;56;56;55;56;58;54 04:47:50 INFO - PROCESS | 1706 | |9;json-stringify-tinderbox;65;63;80;73;71;68;70;69;68;69 04:47:50 INFO - PROCESS | 1706 | |10;stanford-crypto-aes;86;84;87;85;84;86;75;85;95;77 04:47:50 INFO - PROCESS | 1706 | |11;stanford-crypto-ccm;140;140;139;138;135;140;138;151;228;140 04:47:50 INFO - PROCESS | 1706 | |12;stanford-crypto-pbkdf2;168;168;168;170;168;169;166;168;168;168 04:47:50 INFO - PROCESS | 1706 | |13;stanford-crypto-sha256-iterative;68;67;69;68;67;66;66;66;64;67 04:47:50 INFO - PROCESS | 1706 | __end_tp_report 04:47:50 INFO - PROCESS | 1706 | __start_cc_report 04:47:50 INFO - PROCESS | 1706 | _x_x_mozilla_cycle_collect,2108 04:47:50 INFO - PROCESS | 1706 | __end_cc_report 04:47:50 INFO - PROCESS | 1706 | __startTimestamp1471175270759__endTimestamp 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | ------- Summary: start ------- 04:47:50 INFO - PROCESS | 1706 | Number of tests: 14 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:3.58 (3.2%) stddev-sans-first:1.92 04:47:50 INFO - PROCESS | 1706 | Values: 103.0 113.0 114.0 114.0 108.0 113.0 112.0 114.0 113.0 114.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:140.50 stddev:28.84 (20.5%) stddev-sans-first:30.27 04:47:50 INFO - PROCESS | 1706 | Values: 143.0 105.0 108.0 163.0 105.0 103.0 157.0 138.0 180.0 108.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:2.59 (1.4%) stddev-sans-first:2.74 04:47:50 INFO - PROCESS | 1706 | Values: 183.0 187.0 186.0 186.0 184.0 184.0 178.0 183.0 182.0 182.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#3] audio-fft Cycles:10 Average:66.50 Median:64.00 stddev:11.49 (18.0%) stddev-sans-first:11.10 04:47:50 INFO - PROCESS | 1706 | Values: 80.0 58.0 59.0 84.0 58.0 57.0 64.0 64.0 84.0 57.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:71.00 stddev:15.17 (21.4%) stddev-sans-first:15.77 04:47:50 INFO - PROCESS | 1706 | Values: 90.0 69.0 107.0 71.0 73.0 69.0 95.0 71.0 68.0 101.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.00 stddev:1.77 (2.0%) stddev-sans-first:1.67 04:47:50 INFO - PROCESS | 1706 | Values: 89.0 84.0 87.0 86.0 87.0 86.0 89.0 84.0 88.0 87.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:93.00 stddev:13.68 (14.7%) stddev-sans-first:14.22 04:47:50 INFO - PROCESS | 1706 | Values: 93.0 93.0 94.0 94.0 93.0 93.0 101.0 122.0 130.0 94.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 04:47:50 INFO - PROCESS | 1706 | Values: 85.0 85.0 84.0 86.0 85.0 83.0 86.0 85.0 84.0 83.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.10 (2.0%) stddev-sans-first:1.09 04:47:50 INFO - PROCESS | 1706 | Values: 57.0 55.0 56.0 56.0 56.0 56.0 55.0 56.0 58.0 54.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:4.62 (6.7%) stddev-sans-first:4.59 04:47:50 INFO - PROCESS | 1706 | Values: 65.0 63.0 80.0 73.0 71.0 68.0 70.0 69.0 68.0 69.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.50 stddev:5.46 (6.4%) stddev-sans-first:5.76 04:47:50 INFO - PROCESS | 1706 | Values: 86.0 84.0 87.0 85.0 84.0 86.0 75.0 85.0 95.0 77.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:140.00 stddev:28.10 (20.1%) stddev-sans-first:29.62 04:47:50 INFO - PROCESS | 1706 | Values: 140.0 140.0 139.0 138.0 135.0 140.0 138.0 151.0 228.0 140.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 04:47:50 INFO - PROCESS | 1706 | Values: 168.0 168.0 168.0 170.0 168.0 169.0 166.0 168.0 168.0 168.0 04:47:50 INFO - PROCESS | 1706 | 04:47:50 INFO - PROCESS | 1706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.41 04:47:50 INFO - PROCESS | 1706 | Values: 68.0 67.0 69.0 68.0 67.0 66.0 66.0 66.0 64.0 67.0 04:47:50 INFO - PROCESS | 1706 | -------- Summary: end -------- 04:47:50 INFO - PROCESS | 1706 | 04:47:51 INFO - TEST-INFO | 1706: exit 0 04:47:51 INFO - TEST-OK | kraken | took 59184ms 04:47:51 INFO - SUITE-END | took 1177s 04:47:51 INFO - Completed test suite (00:19:37) 04:47:51 INFO - javascript benchmark 04:47:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3186.9203269918253, 3290.6051273847143, 3327.68556420214, 3331.583552055993, 3333.6833000864926, 5528.612997090206, 5596.384397716253, 5655.208270842086, 5675.0, 5697.6011679182475, 5603.80386686466, 5661.801836935698, 5689.175069614904, 5705.74324155413, 5754.395788442216, 5152.871178220537, 5165.63840531163, 5222.399424066224, 5243.895122097556, 5322.20166974953, 4515.729056256619, 5232.947670523303, 5329.546988505962, 5337.119375303089, 5355.0, 4154.750714957112, 5172.870678233036, 5176.611754118456, 5226.843194704165, 5294.6029047821185, 5203.843884683465, 5206.323177986876, 5225.869353266161, 5227.215917612389, 5227.686338819683, 5150.098732721759, 5180.6891586504935, 5213.895722085575, 5217.8173763918085, 5232.529072383466, 5586.832395028156, 5620.85947851307, 5662.631928924607, 5711.571632127566, 5728.25532680753, 6186.721597528077, 6188.164597779287, 6198.938010619881, 6225.906611400787, 6231.968840155816, 6086.817395478142, 6202.162708034448, 6246.469050130744, 6255.843603909893, 6257.342978987186, 5742.74157662902, 5751.856203594902, 5816.76732930678, 5834.183214349994, 5836.2412886325355, 6217.253929528486, 6220.471259942865, 6237.875242495124, 6252.781152659726, 6255.499560035278, 5960.344362120163, 6194.845128871814, 6197.504199664016, 6202.906956395657, 6216.720247588869, 6077.87274453938, 6154.323024467305, 6155.199824022938, 6179.5056395488255, 6232.781852635227, 6220.62676239418, 6223.408776166257, 6227.408396202444, 6236.6258024518675, 6242.313345531988, 6207.162033125561, 6253.0, 6257.7184026718905, 6266.373362663789, 6270.372962703693, 4837.95162048382, 4881.804727810848, 4924.162892308244, 4926.113299606105, 4963.205887058053, 4404.097160082176, 4404.6035856772405, 4407.338899165086, 4428.468583769968, 4428.933565996513, 5757.395473475309, 5776.335721392094, 5783.826485205451, 5794.681292528867, 5827.067669172912, 6109.677964501087, 6142.662153581507, 6173.135760993465, 6182.505399568024, 6183.938160618336, 5758.596898217084, 5770.076787713946, 5772.163036359789, 5808.535317174616, 5849.239598852122, 5431.131019036935, 5438.2386465894015, 5439.428859969726, 5443.482869127427, 5447.754851031713, 6181.443670069805, 6222.688865556614, 6235.532335074979, 6257.561970662101, 6277.811665650038, 6318.368163183645, 6321.683915804283, 6323.9683801580695, 6324.873502530016, 6331.05034244867, 6268.091126786681, 6324.968375158095, 6334.714937827901, 6342.365763423621, 6377.043443483514, 6114.266288045463, 6124.3809352984035, 6131.713108457373, 6135.294441139147, 6219.720112595034, 6265.15420418256, 6268.561200715906, 6269.028300613412, 6276.9372306276355, 6289.150964619717, 5876.941230587639, 6068.696565171812, 6111.113888486234, 6115.816525504242, 6127.234095738033, 5772.94227057724, 5934.6142500737315, 5955.464008239279, 5964.0, 6002.219711437485, 5834.15404766298, 5834.445727655866, 5839.854003649943, 5847.532197424111, 5886.175935368966, 6056.27299402718, 6059.787907423219, 6062.575619706578, 6063.757449701962, 6101.084837274267, 5686.573506987075, 5716.399778023414, 5766.567507437043, 5869.94130058711, 5890.734916928663], "value": 5678.196397016387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.6187031310108, 493.7901391908438, 518.7250757098737, 532.661759782538, 533.128335171994, 30534.54198187026, 40963.79518102409, 41513.37729934046, 42077.0, 44087.55912440875, 43089.78455107728, 43390.56609433905, 43502.56497435024, 43513.34729979045, 43564.564354356444, 8858.069902660225, 9868.999999999982, 9962.750931226705, 9963.302568820185, 9976.451295178762, 8830.028696843374, 11958.402079896014, 12225.816612750816, 12244.571439999601, 12422.316772577504, 12147.878521214763, 12215.022798176169, 12233.816492752616, 12254.877451225462, 12288.938555307255, 8930.330225233134, 12114.81827772584, 12190.695232619168, 12289.446974886107, 12292.201006934522, 11761.411929403495, 12166.756664866742, 12169.817452738216, 12171.391430428443, 12199.085068619888, 40254.0, 40327.7983610083, 40561.0, 40624.0, 40730.38904416436, 2890.624218851557, 3188.852013275219, 3328.3010567780793, 3494.825258737053, 3499.107727529464, 31462.685373146203, 31486.0, 31670.89151879696, 32090.518642220384, 32627.51058734121, 3116.4546204414364, 3221.2108033531936, 3253.268014696698, 3265.8856940006985, 3388.2207092368894, 517370.0, 522359.0, 523377.0, 526376.0, 526645.0, 60388.396116038275, 60940.0, 61042.38957610456, 61117.38882611117, 61175.69412152911, 33930.0, 34076.82961585176, 34337.394573569414, 35536.289274214374, 35885.28229435449, 16609.41867034648, 16720.996740195627, 16727.996320220584, 16739.16304184786, 16749.413770517975, 11647.534098635959, 11812.822807657893, 12607.621771346874, 12772.233665980071, 12869.292188929512, 18549.0, 18839.529011774543, 18863.339783107524, 18939.81060189408, 18943.62112757737, 6270.6864656766975, 7687.807804804925, 7734.613269336511, 7770.261825126604, 7801.336886364723, 700.4816435837444, 732.8754111801006, 870.7823044238941, 1004.382304882492, 1049.6011515624166, 28745.712542874302, 29996.700032999826, 29997.250068748457, 30758.92343768002, 30811.0, 1055.1031623120439, 1081.4646749858714, 1114.414932160606, 1116.6650004998469, 1123.43828085957, 12867.871321286855, 15700.607484812743, 15880.444184453489, 16190.0, 17036.14819259032, 682937.0, 687442.0, 688613.0, 690024.0, 691489.0, 48330.0, 59411.0, 59447.405525945054, 59456.40543594509, 59489.0, 1222.3093951917137, 1275.4515558310015, 1277.9872201278054, 1369.5688006033718, 1401.516476815497, 22268.331950041524, 27086.864565677835, 31106.844465777525, 31819.0, 32396.190095246864, 42726.57273427226, 50166.74916625393, 50335.496645034546, 50343.49656503535, 50448.49551504585, 537659.0, 542123.2893835505, 542616.0, 542953.0, 543577.0, 21642.24252151167, 26977.3255668602, 27264.454710906066, 27363.315917101434, 28511.28721781972, 47256.054878901545, 47501.76249118732, 48134.27798582954, 48233.75883120702, 48296.75851620719, 39097.41353879637, 39375.80312098421, 39556.0, 39721.40417893676, 40931.1813763729, 39188.02029949274, 39571.81284561468, 39929.60070399259, 40835.38746918739, 41399.1720165589, 38227.235455291295, 39114.02214944535, 39274.80362598169, 39333.40999885061, 39394.2121157581, 29905.70094299029, 32595.0, 34659.30681386409, 34859.82570087133, 35014.0, 24293.514129716954, 25397.87301063483, 25473.23580292594, 26093.347666308495, 26109.0], "value": 20143.36994897437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.78475022611303, 372.31122423516496, 372.8005517048378, 383.38083994349137, 405.9951619741141, 15865.84134158658, 15911.28399222035, 17591.472255832312, 19093.904530477364, 20548.178072877086, 20535.794642053574, 21140.0, 21226.83252421116, 21324.893375533138, 21562.814045227507, 5833.416658334154, 5936.643801371932, 6036.607620504675, 6211.565190436671, 6219.875602487948, 4193.643540299078, 6009.399060094, 6106.664133472657, 6108.389161083878, 6120.81637550872, 6402.519811014193, 6722.495812814059, 6744.2244141923575, 6788.762393316235, 6804.353586409308, 6599.835004124887, 6698.263191048981, 6727.293634168391, 6767.390934815866, 6809.761658341934, 5808.88382232353, 5838.7080645967535, 5841.678707671076, 5854.824355269348, 5859.4140585941495, 24148.517029659484, 24605.261842144766, 25100.0, 25251.873740631177, 25432.728363581748, 2116.216999710102, 2198.7801219877883, 2204.1164678562136, 2366.2782851230368, 2554.6040363743464, 8296.626651800623, 10284.794304113952, 10391.792164156675, 16399.508014759576, 16808.663826723398, 1942.4464027752165, 1966.7049942508595, 1968.7243785869846, 2026.5440275937945, 2088.1960445228547, 109870.90129098686, 113774.0, 131888.3405582966, 131960.0, 141215.0, 14495.042468451009, 20344.0, 20634.0, 20808.687869681966, 21072.0, 34383.0, 34433.483497747555, 34522.48216276758, 34624.307513849584, 34628.30743385118, 10370.429626370622, 10761.730956726144, 10948.0, 10953.890461095287, 11131.551058767058, 7327.413806895435, 8982.326325525612, 9037.50293733851, 9144.679936202201, 9166.26669866409, 9337.159655631025, 9519.286053545873, 9559.808803823884, 9672.95163524178, 9677.274204434696, 3570.1967057411875, 3648.3980143276594, 3648.8175591220333, 3660.5058317126845, 3669.2661467706566, 839.6515446089926, 847.0513025411578, 858.8234119256658, 880.6741505642825, 943.834828904939, 19993.400197994084, 21076.367708968755, 21876.562468750853, 21946.231881884058, 21983.34049978503, 910.6266430763355, 926.6617684545092, 929.9628014879464, 949.5299826585746, 967.6129548180784, 10311.84532232017, 10645.254832161674, 10839.024487795978, 11571.01646360052, 11589.826152607717, 602562.0, 610071.0, 618296.0, 620792.0, 622932.0, 130309.04536431961, 131035.34482327718, 131545.68454315525, 132271.3545729099, 134040.32979835037, 872.9039805621377, 914.5427286356821, 947.5404428852002, 981.8919918809069, 983.2772911909883, 19794.60410791805, 20155.899220503805, 20357.287494937606, 20361.79638203599, 20373.879436630534, 55151.17273240985, 55922.44077559172, 56261.718691406284, 56512.71743641255, 57397.71301143467, 74549.13627159147, 76965.2303476958, 82058.9220455231, 87191.0, 88893.11106889107, 7851.528908265523, 7967.4060660932455, 8012.679492820222, 8353.415260931919, 8504.659813607386, 11503.367314797766, 12714.61856144317, 12892.226466412045, 13092.607221783363, 13429.194248345131, 10504.474776261004, 11346.659600212008, 11552.191346605992, 11562.537498499965, 11647.30116193031, 10751.408672523086, 11080.39057851826, 11340.979311861973, 11374.54501819918, 11669.474873630877, 11145.554177832795, 11257.605983790529, 11716.472758725708, 11813.704657383634, 11881.405929703307, 7572.924270757222, 8247.628856701343, 8284.295834854105, 8353.0811610724, 8377.947402886331, 10188.89811101909, 11072.723181920517, 11312.547498100314, 11316.830247546459, 11410.82883756761], "value": 10648.949604643549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.1567637799212, 1558.3844381469316, 1723.7931448226216, 1850.3986204483547, 1863.972040419394, 8508.914910850897, 9101.998780134196, 9107.358865928889, 9110.043445438232, 9112.726618201455, 7933.920660793405, 8190.344772418207, 8620.784480387994, 8834.867476987834, 8872.911270887289, 2319.652052192172, 2342.0397636968846, 2351.776581224781, 2354.5173239485866, 2359.327591636384, 2315.4211447138214, 2318.3624503261653, 2382.106709983756, 2387.7015373078366, 2392.0, 1727.697652910742, 2076.3874656976154, 2157.5145592241697, 2158.816500597451, 2161.6433288507455, 2281.954360912781, 2364.728056273533, 2367.633016882386, 2371.5968285391523, 2380.9523809523885, 1913.7799153097433, 2333.241696448661, 2339.1462116327416, 2339.4853132310864, 2341.7424083350816, 8869.467831930106, 9047.728568142966, 9064.957529884015, 9073.047330030318, 9081.318901082379, 5275.155975043975, 5428.430014848463, 5429.53848922842, 5440.510354068113, 5446.945530544684, 3587.8600425285185, 3688.3729765939856, 3747.306748251582, 3748.4939533162947, 3762.322781899257, 1079.94060326682, 1118.2619471149003, 1129.5764088466824, 1146.9369184694838, 1148.1847887999531, 11992.820107698391, 12021.639350819489, 12030.278183308941, 12060.638180854588, 12070.215435996632, 4616.930746038812, 4641.18779213643, 4819.7108173509005, 4872.171730805771, 4872.975635121802, 10109.140723038625, 10115.44365059914, 10130.189584833195, 10133.442660653587, 10152.39085654863, 5410.053240682943, 5411.783528658888, 5427.375851777097, 5427.43011983744, 5436.477786219864, 4760.64295177863, 4901.142300097468, 4952.232403977389, 4973.577245934064, 4992.750362481861, 3936.488256526633, 3962.8018599069933, 4042.2521833460905, 4093.0, 4105.609967053125, 1270.720441502868, 1292.7931530955002, 1294.643972907439, 1310.8754668306497, 1310.9803352949714, 859.6733241368365, 868.5440143924363, 873.8116162019649, 920.521328908977, 952.3761935931838, 4455.977720111444, 5064.012517559041, 5805.274340707411, 5887.735051922674, 6179.073139029092, 427.890887823603, 430.12898879768096, 434.97390156590706, 435.3274191374271, 452.1747810246248, 3824.3116239076676, 3874.2638898609175, 3994.900127496836, 4025.2352053109817, 4074.388841673713, 10529.0, 10923.508442120125, 10924.2899211551, 10937.890621093688, 10947.069499092508, 10857.0, 10867.45662716861, 10891.965263299973, 11012.944935275273, 11071.05895998833, 8019.198080191934, 8121.715739949073, 8239.917600824036, 8284.25441710237, 8334.749957501284, 5917.615355001911, 5935.851603709942, 5936.5455463411745, 6013.579049466671, 6025.307089684742, 9830.4101753895, 10207.132393746615, 10256.743581410525, 10262.743431413975, 10294.3823370595, 7044.8591028178125, 10211.540480678239, 10216.438095904796, 10233.692989210336, 10371.429571373646, 7610.124835643972, 7743.45795794289, 7751.496152750054, 7756.92243077562, 7761.107472640493, 8239.093699693149, 8341.66633334684, 8420.621072051896, 8443.704470343508, 8454.704085356983, 7487.401007919245, 7640.426967977312, 7657.961710191414, 7679.616019198906, 7761.4178936578855, 6385.233771947396, 7308.744193953186, 7416.7033318666645, 7433.405327573889, 7581.50720203185, 6183.412575805291, 7048.436125110082, 7066.681999310146, 7068.5758854468895, 7157.105361829771, 4318.78406079701, 5040.16837221869, 5058.797648094035, 5079.009593129304, 5194.4805519447755, 5029.84910452687, 5118.769655365443, 5153.123968925217, 5231.738413079407, 5324.414314425488], "value": 4522.709509209382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [248.975102489751, 305.5783019433182, 308.4001616855216, 312.35031135238694, 318.4474935986065, 4506.23394023016, 5115.5651769599535, 5282.151247063526, 5299.867503312409, 5329.227262047001, 3949.9802500987453, 5238.607104467161, 5239.004589128063, 5282.128448805952, 5306.124489459235, 3114.2594516825275, 3856.633619806114, 3974.3839704845795, 4019.934717299918, 4030.435738996543, 3473.791572505645, 3786.129190286236, 4024.7182697211206, 4059.391091336294, 4061.756294622332, 3966.3455529837543, 3985.2464915437113, 3989.6209860063245, 3998.3002974479496, 4003.5596084430836, 3066.4480393529043, 3850.190410507057, 3862.8841134766003, 3867.207222519377, 4034.213328400963, 2942.073246927211, 3481.89554313371, 3506.4740288956605, 3507.736919731005, 3509.210427653783, 4473.418455600751, 5128.897422051576, 5150.716710580917, 5180.021487644582, 5185.740712964337, 4551.772411379451, 4656.813727450898, 4657.860264192046, 4660.300954856764, 4699.600533954618, 5083.796648134107, 5538.861528461781, 5560.833175004756, 5588.050031494656, 5606.439356064361, 3224.790388624732, 3904.754766009556, 3910.667593254577, 3923.8609112710005, 3934.976906004431, 4740.620750340034, 5694.889496548175, 5798.9420105799245, 5963.731632076567, 5966.522678185735, 3895.331697787025, 3913.491246137984, 3931.9017024574614, 3932.9745181231115, 3950.4395763673188, 3993.2412841560013, 4000.5195479932645, 4009.719319647655, 4031.697622678311, 4041.6968727345566, 4597.963517992849, 4642.303654451859, 4661.067786442725, 4692.732962100214, 4692.976535117303, 4379.321205213197, 5474.562035037187, 5534.4742249486235, 5604.3835178130375, 5629.832514481954, 1270.8157317188957, 1279.1835593457313, 1360.4558176729388, 1380.3995262061035, 1396.0227840511682, 794.4161041634394, 843.0220943705273, 849.907868389117, 854.1501206299771, 858.6176256227469, 3946.723729338919, 4188.308929026737, 4351.455233392164, 4860.392450943632, 5145.536901678867, 5014.0, 5628.577856660685, 5760.251167348218, 5779.88440231193, 5798.362180160179, 5167.785570390955, 5174.66234278888, 5182.818601348935, 5190.351206099238, 5197.688138711689, 2387.8180300751237, 2711.4848178845955, 2975.6577993530586, 3044.3911217756536, 3050.4661684205175, 5210.505002024802, 5942.4150494535015, 6005.789797357159, 6012.098185272244, 6051.062085376773, 5002.199648056294, 5078.492150784892, 5459.2629994950175, 5634.887302254014, 5979.372165922602, 5073.974630126826, 5995.820125396245, 6053.303870054824, 6076.574639775174, 6152.0, 4552.6813123081065, 5522.923030009109, 5542.806001789918, 5764.625299355528, 5850.180974663635, 4782.808687652594, 5569.020573992894, 5763.73483622125, 5778.248827652546, 5793.9581719597545, 5650.26546548946, 5995.5803093783015, 6031.487323577545, 6044.274687037584, 6112.724927378367, 3008.714172153642, 3340.983295083606, 3916.5508761758333, 3964.583718709494, 4017.5536806750133, 4120.979395103005, 5632.971835140798, 5789.2763404574425, 5794.101914203306, 5811.314718731521, 5142.562882154909, 5611.607187496836, 5671.0, 5671.865626874559, 5678.801241956677, 4586.945002649342, 4837.612990960644, 5558.249636299048, 5656.179853921076, 5656.830295091154, 4569.81720731167, 5320.707361095177, 5332.70670113132, 5569.55443564522, 5577.330720313588, 4879.365682461257, 5334.106102545241, 5538.529225015919, 5646.830595082154, 5667.296144200386, 4416.4258646375765, 5060.861306206074, 5423.159410291411, 5432.456754324536, 5446.840832317325], "value": 4047.138871218569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.884848999915, 733.9211359301825, 775.1473379282786, 813.812823050698, 851.6976473351962, 14804.851951480481, 15407.69184616307, 16107.83892161078, 16138.596535086628, 16335.59161020975, 14696.632584185374, 14770.335334909929, 14920.626984325398, 14957.551273461786, 15077.849221507782, 690.492488021304, 843.6667516331046, 863.7322430046705, 864.3776480933718, 865.7186414415308, 702.0942983551213, 827.8054657155564, 846.4413487098516, 854.1117238072397, 856.2379482260793, 908.8636704494313, 908.9772755681095, 912.3886995712888, 912.9497877616728, 913.9497327646977, 712.9536580122327, 904.2268860124631, 906.0576999920075, 906.4334790755778, 909.7589138878136, 651.882661120998, 668.1180841289499, 669.100060418736, 669.243754557352, 676.2730065179951, 14745.631359215999, 14788.630284242872, 14798.0, 14800.259987000607, 14805.03767255125, 13602.659933501644, 13937.0, 14021.5092471763, 14024.859751402457, 14183.929080354636, 12684.682882927907, 12748.0, 12835.229886206858, 12953.740925181537, 13014.674633134153, 4487.708298960557, 4491.573300536444, 4533.365328853963, 4580.0, 4616.561426664462, 114993.85006149915, 115398.0, 115894.0, 116743.0, 116840.41579792132, 10703.892961070445, 10938.945305273583, 11264.26782259167, 11317.434128293553, 11563.132765042656, 21319.0, 21352.466188345104, 21378.679319810217, 21388.572228555342, 21392.679109813365, 7787.260210280015, 7911.050673919167, 7983.640736166886, 8078.071021832447, 8093.19068093186, 4261.446012018479, 4321.092570560155, 4412.823487060482, 4465.0623369092855, 4483.21543729846, 3436.639152888961, 3545.2554963457965, 3549.503069570262, 3549.574051113883, 3560.643935606419, 572.584875964922, 681.1451628206668, 707.4411215140085, 717.3328804212133, 738.0073800737999, 554.2711334594994, 585.2450339062561, 671.6037537852691, 690.6098054599236, 694.8992396102536, 9223.492707900996, 9577.0, 9912.55393507294, 9922.0, 9957.253206009578, 538.8625900395374, 566.6373520946597, 583.2971269620098, 592.6177615438019, 656.3108735827362, 4258.233517966796, 4738.8341408050555, 4762.9521505268785, 4790.5448982346625, 4814.825820382479, 120889.0, 161961.0, 167400.0, 169400.0, 177373.0, 136274.3186284062, 138965.0, 141829.99999999793, 145221.27389362987, 146889.0, 98630.0, 102258.48870755748, 103888.0, 105443.41834872484, 105959.47020264849, 9801.11789938909, 10044.0, 10106.949465252626, 10190.643327483502, 10215.693529194135, 57808.1328780077, 58373.416265838496, 60778.39221607727, 62335.06497402452, 62887.17007734571, 71653.92519112321, 75794.24205758092, 89914.55042724745, 93354.53322733344, 96043.0, 13424.194548327132, 13629.250391228577, 13636.113652612548, 13809.585712428643, 14145.717085658434, 14732.189729564976, 15139.772903406678, 15294.46469373611, 15614.0, 15673.216339182767, 13931.094478858842, 14143.434262629791, 14146.858531414555, 14368.928155359155, 14433.422663093359, 11197.552097915992, 13807.792883106962, 14248.786268205778, 14253.073550219202, 14277.0, 13735.064110197896, 13913.0, 13920.58238252854, 13996.16023038621, 14320.283985800459, 11153.609623663133, 11312.20814543007, 11651.242669226473, 11661.24201926872, 12011.939940300243, 10720.678379648623, 10752.623658171926, 11488.36813975206, 11680.824787628362, 11692.88307116952], "value": 7966.603797025943, "unit": "score"}], "name": "dromaeo_css", "value": 7497.556389023639, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 114.0, 108.0, 113.0, 112.0, 114.0, 113.0, 114.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 105.0, 108.0, 163.0, 105.0, 103.0, 157.0, 138.0, 180.0, 108.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 186.0, 186.0, 184.0, 184.0, 178.0, 183.0, 182.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 84.0, 58.0, 57.0, 64.0, 64.0, 84.0, 57.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 107.0, 71.0, 73.0, 69.0, 95.0, 71.0, 68.0, 101.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 87.0, 86.0, 87.0, 86.0, 89.0, 84.0, 88.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 101.0, 122.0, 130.0, 94.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 85.0, 83.0, 86.0, 85.0, 84.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 58.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 80.0, 73.0, 71.0, 68.0, 70.0, 69.0, 68.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 85.0, 84.0, 86.0, 75.0, 85.0, 95.0, 77.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 139.0, 138.0, 135.0, 140.0, 138.0, 151.0, 228.0, 140.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 170.0, 168.0, 169.0, 166.0, 168.0, 168.0, 168.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 68.0, 67.0, 66.0, 66.0, 66.0, 64.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1439.9, "alertThreshold": 2.0}]} 04:47:52 INFO - Return code: 0 04:47:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:52 INFO - # TBPL SUCCESS # 04:47:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:52 INFO - 2016-08-14 04:47:52.110 screenresolution[1710:18747] starting screenresolution argv=screenresolution get 04:47:52 INFO - 2016-08-14 04:47:52.112 screenresolution[1710:18747] Display 0: 1600x1200x32@60 04:47:52 INFO - 2016-08-14 04:47:52.118 screenresolution[1711:18750] starting screenresolution argv=screenresolution list 04:47:52 INFO - Available Modes on Display 0 04:47:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:52 INFO - Intel Iris: 04:47:52 INFO - Chipset Model: Intel Iris 04:47:52 INFO - Type: GPU 04:47:52 INFO - Bus: Built-In 04:47:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:52 INFO - Vendor: Intel (0x8086) 04:47:52 INFO - Device ID: 0x0a2e 04:47:52 INFO - Revision ID: 0x0009 04:47:52 INFO - Displays: 04:47:52 INFO - Display: 04:47:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:52 INFO - Display Serial Number: 1600x1200 60 04:47:52 INFO - Main Display: Yes 04:47:52 INFO - Mirror: Off 04:47:52 INFO - Online: Yes 04:47:52 INFO - Rotation: Supported 04:47:52 INFO - Return code: 0 04:47:52 INFO - Running post-action listener: _resource_record_post_action 04:47:52 INFO - [mozharness: 2016-08-14 11:47:52.355390Z] Finished run-tests step (success) 04:47:52 INFO - Running post-run listener: _resource_record_post_run 04:47:52 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32488448; Write bytes: 706650112; Read time: 304; Write time: 2007 04:47:52 INFO - TinderboxPrint: CPU usage
53.5% 04:47:52 INFO - TinderboxPrint: I/O read bytes / time
32,488,448 / 304 04:47:52 INFO - TinderboxPrint: I/O write bytes / time
706,650,112 / 2,007 04:47:52 INFO - TinderboxPrint: CPU idle
2,254.8 (46.5%) 04:47:52 INFO - TinderboxPrint: CPU system
969.4 (20.0%) 04:47:52 INFO - TinderboxPrint: CPU user
1,625.5 (33.5%) 04:47:52 INFO - TinderboxPrint: Swap in / out
433,557,504 / 0 04:47:52 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398326272; Write bytes: 393017344; Read time: 29542; Write time: 714 04:47:52 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30387200; Write bytes: 297506816; Read time: 279; Write time: 1249 04:47:52 INFO - Running post-run listener: _upload_blobber_files 04:47:52 INFO - Blob upload gear active. 04:47:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:52 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 04:47:52 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:47:52 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:47:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:54 INFO - (blobuploader) - INFO - Done attempting. 04:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:54 INFO - (blobuploader) - INFO - Done attempting. 04:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:57 INFO - (blobuploader) - INFO - Done attempting. 04:47:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:57 INFO - Return code: 0 04:47:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a9b2f8ec9e2e54d62af6f51370983585df8239c81fd803abc16411269f6694e60004646b05632184c4a755cb2798989bddda21d992528d2592d97c6bfe862c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316daa252afbe0c5c19675068badd7cd944ed4a38cd4a04101f22bf9c91ea920e4742ad5574d7f7d630f3618e03d3bd35df92f6a5381ce6ffaeb71ae55ea78f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4121277bcb84f458fd33d8552e64f988d92086490d36d4b6bc88a8f887e2e92678cf18b453bbef83a27fd00a227673e552829e64dceee6624e4d04386314a6cb"} 04:47:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:57 INFO - Contents: 04:47:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a9b2f8ec9e2e54d62af6f51370983585df8239c81fd803abc16411269f6694e60004646b05632184c4a755cb2798989bddda21d992528d2592d97c6bfe862c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316daa252afbe0c5c19675068badd7cd944ed4a38cd4a04101f22bf9c91ea920e4742ad5574d7f7d630f3618e03d3bd35df92f6a5381ce6ffaeb71ae55ea78f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4121277bcb84f458fd33d8552e64f988d92086490d36d4b6bc88a8f887e2e92678cf18b453bbef83a27fd00a227673e552829e64dceee6624e4d04386314a6cb"} 04:47:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:57 INFO - Copying logs to upload dir... 04:47:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.908960 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-14 04:47:57.719034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-14 04:47:57.722524) ========= 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.9lMzTxeEMX/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.NksRiTjbZR/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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/Firefox/sha512/7a9b2f8ec9e2e54d62af6f51370983585df8239c81fd803abc16411269f6694e60004646b05632184c4a755cb2798989bddda21d992528d2592d97c6bfe862c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316daa252afbe0c5c19675068badd7cd944ed4a38cd4a04101f22bf9c91ea920e4742ad5574d7f7d630f3618e03d3bd35df92f6a5381ce6ffaeb71ae55ea78f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4121277bcb84f458fd33d8552e64f988d92086490d36d4b6bc88a8f887e2e92678cf18b453bbef83a27fd00a227673e552829e64dceee6624e4d04386314a6cb"} build_url:https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/Y2akdAwGSBeipoOWBC4VTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a9b2f8ec9e2e54d62af6f51370983585df8239c81fd803abc16411269f6694e60004646b05632184c4a755cb2798989bddda21d992528d2592d97c6bfe862c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316daa252afbe0c5c19675068badd7cd944ed4a38cd4a04101f22bf9c91ea920e4742ad5574d7f7d630f3618e03d3bd35df92f6a5381ce6ffaeb71ae55ea78f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4121277bcb84f458fd33d8552e64f988d92086490d36d4b6bc88a8f887e2e92678cf18b453bbef83a27fd00a227673e552829e64dceee6624e4d04386314a6cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-14 04:47:57.756151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 04:47:57.756483) ========= 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.9lMzTxeEMX/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.NksRiTjbZR/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.005212 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 04:47:57.824247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-14 04:47:57.824617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-14 04:47:57.825514) ========= ========= Total master_lag: 0.20 =========