builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0090 starttime: 1474538826.99 results: success (0) buildid: 20160922012659 builduid: 54643daddcb64ac2a6aa74a3ba38db8e revision: 28a35f4aa671e246cce2b9920da3a482724210b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:06.993686) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:06.994154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:06.994434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:07.031341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:07.031693) ========= 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.hpONUwXW1P/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.ox2pnjLqad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-09-22 03:07:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-09-22 03:07:07 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.611599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:07.666797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:07.670120) ========= 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.hpONUwXW1P/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.ox2pnjLqad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.028099 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:07.728782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:07.729142) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 28a35f4aa671e246cce2b9920da3a482724210b7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 28a35f4aa671e246cce2b9920da3a482724210b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hpONUwXW1P/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.ox2pnjLqad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-09-22 03:07:07,784 truncating revision to first 12 chars 2016-09-22 03:07:07,784 Setting DEBUG logging. 2016-09-22 03:07:07,784 attempt 1/10 2016-09-22 03:07:07,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/28a35f4aa671?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 03:07:08,476 unpacking tar archive at: autoland-28a35f4aa671/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951790 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:08.703963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:08.704299) ========= script_repo_revision: 28a35f4aa671e246cce2b9920da3a482724210b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:08.704712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:08.705012) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 03:07:08.728949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-09-22 03:07:08.729252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hpONUwXW1P/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.ox2pnjLqad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:08 INFO - MultiFileLogger online at 20160922 03:07:08 in /builds/slave/test 03:07:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:07:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:07:08 INFO - {'append_to_log': False, 03:07:08 INFO - 'base_work_dir': '/builds/slave/test', 03:07:08 INFO - 'blob_upload_branch': 'Autoland', 03:07:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:07:08 INFO - 'branch': 'Autoland', 03:07:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:08 INFO - 'config_files': ('talos/mac_config.py',), 03:07:08 INFO - 'default_actions': ('clobber', 03:07:08 INFO - 'read-buildbot-config', 03:07:08 INFO - 'download-and-extract', 03:07:08 INFO - 'populate-webroot', 03:07:08 INFO - 'create-virtualenv', 03:07:08 INFO - 'install', 03:07:08 INFO - 'run-tests'), 03:07:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:08 INFO - 'download_minidump_stackwalk': True, 03:07:08 INFO - 'download_symbols': 'ondemand', 03:07:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:07:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:07:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:07:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:07:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:08 INFO - 'installer_path': 'installer.exe', 03:07:08 INFO - 'log_level': 'info', 03:07:08 INFO - 'log_name': 'talos', 03:07:08 INFO - 'log_to_console': True, 03:07:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:07:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:07:08 INFO - 'opt_config_files': (), 03:07:08 INFO - 'pip_index': False, 03:07:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:07:08 INFO - 'cmd': ('bash', 03:07:08 INFO - '-c', 03:07:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:07:08 INFO - 'enabled': True, 03:07:08 INFO - 'halt_on_failure': False, 03:07:08 INFO - 'name': 'check_screen_resolution'},), 03:07:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:07:08 INFO - 'cmd': ('bash', 03:07:08 INFO - '-c', 03:07:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:07:08 INFO - 'enabled': True, 03:07:08 INFO - 'halt_on_failure': False, 03:07:08 INFO - 'name': 'check_screen_resolution'},), 03:07:08 INFO - 'run_cmd_checks_enabled': True, 03:07:08 INFO - 'sps_profile': False, 03:07:08 INFO - 'sps_profile_interval': 0, 03:07:08 INFO - 'suite': 'dromaeojs', 03:07:08 INFO - 'system_bits': '32', 03:07:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:08 INFO - 'title': 't-yosemite-r7-0090', 03:07:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:08 INFO - 'use_talos_json': True, 03:07:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:07:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:08 INFO - 'work_dir': 'build'} 03:07:08 INFO - [mozharness: 2016-09-22 10:07:08.915661Z] Running clobber step. 03:07:08 INFO - Running pre-action listener: _resource_record_pre_action 03:07:08 INFO - Running main action method: clobber 03:07:08 INFO - rmtree: /builds/slave/test/build 03:07:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:07:11 INFO - Running post-action listener: _resource_record_post_action 03:07:11 INFO - [mozharness: 2016-09-22 10:07:11.063194Z] Finished clobber step (success) 03:07:11 INFO - [mozharness: 2016-09-22 10:07:11.063330Z] Running read-buildbot-config step. 03:07:11 INFO - Running pre-action listener: _resource_record_pre_action 03:07:11 INFO - Running main action method: read_buildbot_config 03:07:11 INFO - Using buildbot properties: 03:07:11 INFO - { 03:07:11 INFO - "project": "", 03:07:11 INFO - "product": "firefox", 03:07:11 INFO - "script_repo_revision": "production", 03:07:11 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 03:07:11 INFO - "repository": "", 03:07:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 03:07:11 INFO - "buildid": "20160922012659", 03:07:11 INFO - "pgo_build": "False", 03:07:11 INFO - "basedir": "/builds/slave/test", 03:07:11 INFO - "buildnumber": 289, 03:07:11 INFO - "slavename": "t-yosemite-r7-0090", 03:07:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:07:11 INFO - "platform": "yosemite_r7", 03:07:11 INFO - "scheduler": "tests-autoland-macosx64-talos", 03:07:11 INFO - "branch": "autoland", 03:07:11 INFO - "repo_path": "integration/autoland", 03:07:11 INFO - "revision": "28a35f4aa671e246cce2b9920da3a482724210b7", 03:07:11 INFO - "stage_platform": "macosx64", 03:07:11 INFO - "builduid": "54643daddcb64ac2a6aa74a3ba38db8e", 03:07:11 INFO - "slavebuilddir": "test" 03:07:11 INFO - } 03:07:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:07:11 INFO - Running post-action listener: _resource_record_post_action 03:07:11 INFO - [mozharness: 2016-09-22 10:07:11.066411Z] Finished read-buildbot-config step (success) 03:07:11 INFO - [mozharness: 2016-09-22 10:07:11.066517Z] Running download-and-extract step. 03:07:11 INFO - Running pre-action listener: _resource_record_pre_action 03:07:11 INFO - Running main action method: download_and_extract 03:07:11 INFO - mkdir: /builds/slave/test/build/tests 03:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:11 INFO - trying https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:07:11 INFO - Downloading https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 03:07:12 INFO - Downloaded 1199 bytes. 03:07:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:07:12 INFO - Using the following test package requirements: 03:07:12 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:07:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:07:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:07:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'jsshell-mac.zip'], 03:07:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:07:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:07:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:07:12 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:07:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:07:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:07:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:07:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:07:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:07:12 INFO - Fetch https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:07:13 INFO - Expected file size: 16434118 03:07:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:07:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:07:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:07:20 INFO - Fetch https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:07:20 INFO - Expected file size: 16434118 03:07:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:07:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:07:27 INFO - Fetch https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:07:27 INFO - Expected file size: 14414059 03:07: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')]} 03:07:28 INFO - trying https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:07:28 INFO - Downloading https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 03:07:31 INFO - Downloaded 111335123 bytes. 03:07:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:07:31 INFO - mkdir: /builds/slave/test/properties 03:07:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:31 INFO - Contents: 03:07:31 INFO - build_url:https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:07:32 INFO - Running post-action listener: _resource_record_post_action 03:07:32 INFO - Running post-action listener: set_extra_try_arguments 03:07:32 INFO - [mozharness: 2016-09-22 10:07:32.362391Z] Finished download-and-extract step (success) 03:07:32 INFO - [mozharness: 2016-09-22 10:07:32.362506Z] Running populate-webroot step. 03:07:32 INFO - Running pre-action listener: _resource_record_pre_action 03:07:32 INFO - Running main action method: populate_webroot 03:07:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:32 INFO - '--tppagecycles', 03:07:32 INFO - '7'], 03:07:32 INFO - 'tests': ['tsvgm']}}, 03:07:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['damp', 'tps']}, 03:07:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'tests': ['damp', 'tps']}, 03:07:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['dromaeo_dom']}, 03:07:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['basic_compositor_video']}, 03:07:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:07:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['a11yr', 03:07:32 INFO - 'ts_paint', 03:07:32 INFO - 'tpaint', 03:07:32 INFO - 'sessionrestore', 03:07:32 INFO - 'sessionrestore_no_auto_restore', 03:07:32 INFO - 'tabpaint']}, 03:07:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['tsvgx', 03:07:32 INFO - 'tsvgr_opacity', 03:07:32 INFO - 'tart', 03:07:32 INFO - 'tscrollx', 03:07:32 INFO - 'cart']}, 03:07:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:32 INFO - 'tsvgr_opacity', 03:07:32 INFO - 'tart', 03:07:32 INFO - 'tscrollx', 03:07:32 INFO - 'cart']}, 03:07:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s'], 03:07:32 INFO - 'tests': ['tp5o']}, 03:07:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'tests': ['tp5o']}, 03:07:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'talos_options': ['--disable-e10s', 03:07:32 INFO - '--xperf_path', 03:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:32 INFO - 'tests': ['tp5n']}, 03:07:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:32 INFO - 'talos_options': ['--xperf_path', 03:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:32 INFO - 'tests': ['tp5n']}}, 03:07:32 INFO - 'talos.zip': {'path': '', 03:07:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:32 INFO - Running post-action listener: _resource_record_post_action 03:07:32 INFO - [mozharness: 2016-09-22 10:07:32.381397Z] Finished populate-webroot step (success) 03:07:32 INFO - [mozharness: 2016-09-22 10:07:32.381535Z] Running create-virtualenv step. 03:07:32 INFO - Running pre-action listener: _resource_record_pre_action 03:07:32 INFO - Running main action method: create_virtualenv 03:07:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:32 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 03:07:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:32 INFO - Using real prefix '/tools/python27' 03:07:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:36 INFO - Installing pip.................done. 03:07:36 INFO - Return code: 0 03:07:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:36 INFO - 'HOME': '/Users/cltbld', 03:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:36 INFO - 'LOGNAME': 'cltbld', 03:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:36 INFO - 'MOZ_NO_REMOTE': '1', 03:07:36 INFO - 'NO_EM_RESTART': '1', 03:07:36 INFO - 'PAGER': '/bin/cat', 03:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:36 INFO - 'PWD': '/builds/slave/test', 03:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:36 INFO - 'SHELL': '/bin/bash', 03:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:36 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:36 INFO - 'USER': 'cltbld', 03:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:36 INFO - 'XPC_FLAGS': '0x0', 03:07:36 INFO - 'XPC_SERVICE_NAME': '0', 03:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:36 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 03:07:36 INFO - Cleaning up... 03:07:36 INFO - Return code: 0 03:07:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:36 INFO - 'HOME': '/Users/cltbld', 03:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:36 INFO - 'LOGNAME': 'cltbld', 03:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:36 INFO - 'MOZ_NO_REMOTE': '1', 03:07:36 INFO - 'NO_EM_RESTART': '1', 03:07:36 INFO - 'PAGER': '/bin/cat', 03:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:36 INFO - 'PWD': '/builds/slave/test', 03:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:36 INFO - 'SHELL': '/bin/bash', 03:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:36 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:36 INFO - 'USER': 'cltbld', 03:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:36 INFO - 'XPC_FLAGS': '0x0', 03:07:36 INFO - 'XPC_SERVICE_NAME': '0', 03:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:36 INFO - Downloading/unpacking psutil>=3.1.1 03:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:40 INFO - Installing collected packages: psutil 03:07:40 INFO - Running setup.py install for psutil 03:07:40 INFO - building 'psutil._psutil_osx' extension 03:07:40 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 03:07:40 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 03:07:40 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 03:07:40 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 03:07:41 INFO - building 'psutil._psutil_posix' extension 03:07:41 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 03:07:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:07:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:07:41 INFO - ^ 03:07:41 INFO - 1 warning generated. 03:07:41 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 03:07:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:41 INFO - Successfully installed psutil 03:07:41 INFO - Cleaning up... 03:07:41 INFO - Return code: 0 03:07:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:07:41 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')]} 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:41 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')]} 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:41 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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:41 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 03:07:41 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 03:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:41 INFO - 'HOME': '/Users/cltbld', 03:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:41 INFO - 'LOGNAME': 'cltbld', 03:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:41 INFO - 'MOZ_NO_REMOTE': '1', 03:07:41 INFO - 'NO_EM_RESTART': '1', 03:07:41 INFO - 'PAGER': '/bin/cat', 03:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:41 INFO - 'PWD': '/builds/slave/test', 03:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:41 INFO - 'SHELL': '/bin/bash', 03:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:41 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:41 INFO - 'USER': 'cltbld', 03:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:41 INFO - 'XPC_FLAGS': '0x0', 03:07:41 INFO - 'XPC_SERVICE_NAME': '0', 03:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:44 INFO - Installing collected packages: mozsystemmonitor 03:07:44 INFO - Running setup.py install for mozsystemmonitor 03:07:44 INFO - Successfully installed mozsystemmonitor 03:07:44 INFO - Cleaning up... 03:07:44 INFO - Return code: 0 03:07:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:44 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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:44 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 03:07:44 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 03:07:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:44 INFO - 'HOME': '/Users/cltbld', 03:07:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:44 INFO - 'LOGNAME': 'cltbld', 03:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:44 INFO - 'MOZ_NO_REMOTE': '1', 03:07:44 INFO - 'NO_EM_RESTART': '1', 03:07:44 INFO - 'PAGER': '/bin/cat', 03:07:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:44 INFO - 'PWD': '/builds/slave/test', 03:07:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:44 INFO - 'SHELL': '/bin/bash', 03:07:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:44 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:44 INFO - 'USER': 'cltbld', 03:07:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:44 INFO - 'XPC_FLAGS': '0x0', 03:07:44 INFO - 'XPC_SERVICE_NAME': '0', 03:07:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:44 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:44 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 03:07:44 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 03:07:44 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 03:07:44 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 03:07:44 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 03:07:44 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 03:07:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:47 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 03:07:47 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 03:07:47 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 03:07:47 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 03:07:47 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 03:07:47 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 03:07:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:47 INFO - warning: no files found matching '*.txt' 03:07:47 INFO - no previously-included directories found matching 'build' 03:07:47 INFO - no previously-included directories found matching 'dist' 03:07:47 INFO - no previously-included directories found matching '.git*' 03:07:47 INFO - Installing collected packages: jsonschema, functools32 03:07:47 INFO - Running setup.py install for functools32 03:07:47 INFO - warning: no files found matching '*.txt' 03:07:47 INFO - no previously-included directories found matching 'build' 03:07:47 INFO - no previously-included directories found matching 'dist' 03:07:47 INFO - no previously-included directories found matching '.git*' 03:07:47 INFO - Successfully installed jsonschema functools32 03:07:47 INFO - Cleaning up... 03:07:47 INFO - Return code: 0 03:07:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:47 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')]} 03:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:47 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')]} 03:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:47 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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:47 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 03:07:47 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 03:07:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:47 INFO - 'HOME': '/Users/cltbld', 03:07:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:47 INFO - 'LOGNAME': 'cltbld', 03:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:47 INFO - 'MOZ_NO_REMOTE': '1', 03:07:47 INFO - 'NO_EM_RESTART': '1', 03:07:47 INFO - 'PAGER': '/bin/cat', 03:07:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:47 INFO - 'PWD': '/builds/slave/test', 03:07:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:47 INFO - 'SHELL': '/bin/bash', 03:07:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:47 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:47 INFO - 'USER': 'cltbld', 03:07:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:47 INFO - 'XPC_FLAGS': '0x0', 03:07:47 INFO - 'XPC_SERVICE_NAME': '0', 03:07:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:48 INFO - Cleaning up... 03:07:48 INFO - Return code: 0 03:07:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:48 INFO - 'HOME': '/Users/cltbld', 03:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:48 INFO - 'LOGNAME': 'cltbld', 03:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:48 INFO - 'MOZ_NO_REMOTE': '1', 03:07:48 INFO - 'NO_EM_RESTART': '1', 03:07:48 INFO - 'PAGER': '/bin/cat', 03:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:48 INFO - 'PWD': '/builds/slave/test', 03:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:48 INFO - 'SHELL': '/bin/bash', 03:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:48 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:48 INFO - 'USER': 'cltbld', 03:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:48 INFO - 'XPC_FLAGS': '0x0', 03:07:48 INFO - 'XPC_SERVICE_NAME': '0', 03:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:51 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 03:07:51 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 03:07:51 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 03:07:51 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 03:07:51 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 03:07:51 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 03:07:51 INFO - Downloading docopt-0.6.1.tar.gz 03:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:52 INFO - Running setup.py install for blobuploader 03:07:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:52 INFO - Running setup.py install for requests 03:07:52 INFO - Running setup.py install for docopt 03:07:52 INFO - Successfully installed blobuploader requests docopt 03:07:52 INFO - Cleaning up... 03:07:52 INFO - Return code: 0 03:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:52 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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:52 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 03:07:52 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 03:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:52 INFO - 'HOME': '/Users/cltbld', 03:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:52 INFO - 'LOGNAME': 'cltbld', 03:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:52 INFO - 'MOZ_NO_REMOTE': '1', 03:07:52 INFO - 'NO_EM_RESTART': '1', 03:07:52 INFO - 'PAGER': '/bin/cat', 03:07:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:52 INFO - 'PWD': '/builds/slave/test', 03:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:52 INFO - 'SHELL': '/bin/bash', 03:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:52 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:52 INFO - 'USER': 'cltbld', 03:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:52 INFO - 'XPC_FLAGS': '0x0', 03:07:52 INFO - 'XPC_SERVICE_NAME': '0', 03:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ui55vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-f25o9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-yJFytU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-6d40Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-VMZsxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-0V0IB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hPi5vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-oRiuqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-awBxgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jmET7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-EMEaBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-mFHavw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-lsB74q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-v58UYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-MnOY89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-aFUihM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-YZKHLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:54 INFO - Running setup.py install for manifestparser 03:07:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:55 INFO - Running setup.py install for mozcrash 03:07:55 INFO - Running setup.py install for mozdebug 03:07:55 INFO - Running setup.py install for mozdevice 03:07:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:07:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:55 INFO - Running setup.py install for mozfile 03:07:55 INFO - Running setup.py install for mozhttpd 03:07:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:55 INFO - Running setup.py install for mozinfo 03:07:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:55 INFO - Running setup.py install for mozInstall 03:07:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Running setup.py install for mozleak 03:07:56 INFO - Running setup.py install for mozlog 03:07:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Running setup.py install for moznetwork 03:07:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Running setup.py install for mozprocess 03:07:56 INFO - Running setup.py install for mozprofile 03:07:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:56 INFO - Running setup.py install for mozrunner 03:07:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:57 INFO - Running setup.py install for mozscreenshot 03:07:57 INFO - Running setup.py install for moztest 03:07:57 INFO - Running setup.py install for mozversion 03:07:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:57 INFO - Cleaning up... 03:07:57 INFO - Return code: 0 03:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:57 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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:07:57 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 03:07:57 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 03:07:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:07:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:57 INFO - 'HOME': '/Users/cltbld', 03:07:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:57 INFO - 'LOGNAME': 'cltbld', 03:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:57 INFO - 'MOZ_NO_REMOTE': '1', 03:07:57 INFO - 'NO_EM_RESTART': '1', 03:07:57 INFO - 'PAGER': '/bin/cat', 03:07:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:57 INFO - 'PWD': '/builds/slave/test', 03:07:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:57 INFO - 'SHELL': '/bin/bash', 03:07:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:07:57 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:07:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:57 INFO - 'USER': 'cltbld', 03:07:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:57 INFO - 'XPC_FLAGS': '0x0', 03:07:57 INFO - 'XPC_SERVICE_NAME': '0', 03:07:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:57 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-EfA0hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:57 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)) 03:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:57 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-fpnwmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ub8_kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Fplm6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-vAr7na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-m9SyuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-e7ymss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-yl_vRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hrNbwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-pLmGEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ZAdMIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:58 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)) 03:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-QYx1VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:59 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)) 03:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-J57DRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:59 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)) 03:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-WZphPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:59 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)) 03:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-KWH74i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:59 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)) 03:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-QFa77S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:59 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)) 03:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-7INszU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:59 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)) 03:07:59 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)) 03:07:59 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)) 03:07:59 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)) 03:07:59 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)) 03:07:59 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)) 03:07:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:59 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 03:07:59 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 03:07:59 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 03:07:59 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 03:07:59 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 03:07:59 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 03:08:02 INFO - Downloading blessings-1.6.tar.gz 03:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:08:02 INFO - Installing collected packages: blessings 03:08:02 INFO - Running setup.py install for blessings 03:08:02 INFO - Successfully installed blessings 03:08:02 INFO - Cleaning up... 03:08:02 INFO - Return code: 0 03:08:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:02 INFO - Reading from file tmpfile_stdout 03:08:02 INFO - Current package versions: 03:08:02 INFO - blessings == 1.6 03:08:02 INFO - blobuploader == 1.2.4 03:08:02 INFO - docopt == 0.6.1 03:08:02 INFO - functools32 == 3.2.3-2 03:08:02 INFO - jsonschema == 2.5.1 03:08:02 INFO - manifestparser == 1.1 03:08:02 INFO - mozInstall == 1.12 03:08:02 INFO - mozcrash == 0.17 03:08:02 INFO - mozdebug == 0.1 03:08:02 INFO - mozdevice == 0.48 03:08:02 INFO - mozfile == 1.2 03:08:02 INFO - mozhttpd == 0.7 03:08:02 INFO - mozinfo == 0.9 03:08:02 INFO - mozleak == 0.1 03:08:02 INFO - mozlog == 3.4 03:08:02 INFO - moznetwork == 0.27 03:08:02 INFO - mozprocess == 0.23 03:08:02 INFO - mozprofile == 0.28 03:08:02 INFO - mozrunner == 6.12 03:08:02 INFO - mozscreenshot == 0.1 03:08:02 INFO - mozsystemmonitor == 0.3 03:08:02 INFO - moztest == 0.7 03:08:02 INFO - mozversion == 1.4 03:08:02 INFO - psutil == 3.1.1 03:08:02 INFO - requests == 1.2.3 03:08:02 INFO - wsgiref == 0.1.2 03:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:02 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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:08:02 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 03:08:02 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 03:08:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:08:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:02 INFO - 'HOME': '/Users/cltbld', 03:08:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:02 INFO - 'LOGNAME': 'cltbld', 03:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:02 INFO - 'MOZ_NO_REMOTE': '1', 03:08:02 INFO - 'NO_EM_RESTART': '1', 03:08:02 INFO - 'PAGER': '/bin/cat', 03:08:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:02 INFO - 'PWD': '/builds/slave/test', 03:08:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:02 INFO - 'SHELL': '/bin/bash', 03:08:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:08:02 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:08:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:02 INFO - 'USER': 'cltbld', 03:08:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:02 INFO - 'XPC_FLAGS': '0x0', 03:08:02 INFO - 'XPC_SERVICE_NAME': '0', 03:08:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 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)) 03:08:03 INFO - Cleaning up... 03:08:03 INFO - Return code: 0 03:08:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:03 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 0x1017cd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101743570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde51c87210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, '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.hpONUwXW1P/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.ox2pnjLqad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 03:08:03 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 03:08:03 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 03:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:03 INFO - 'HOME': '/Users/cltbld', 03:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:03 INFO - 'LOGNAME': 'cltbld', 03:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:03 INFO - 'MOZ_NO_REMOTE': '1', 03:08:03 INFO - 'NO_EM_RESTART': '1', 03:08:03 INFO - 'PAGER': '/bin/cat', 03:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:03 INFO - 'PWD': '/builds/slave/test', 03:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:03 INFO - 'SHELL': '/bin/bash', 03:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:08:03 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:03 INFO - 'USER': 'cltbld', 03:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:03 INFO - 'XPC_FLAGS': '0x0', 03:08:03 INFO - 'XPC_SERVICE_NAME': '0', 03:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:08:03 INFO - Cleaning up... 03:08:03 INFO - Return code: 0 03:08:03 INFO - Running post-action listener: _resource_record_post_action 03:08:03 INFO - Running post-action listener: _start_resource_monitoring 03:08:03 INFO - Starting resource monitoring. 03:08:03 INFO - [mozharness: 2016-09-22 10:08:03.332759Z] Finished create-virtualenv step (success) 03:08:03 INFO - [mozharness: 2016-09-22 10:08:03.333562Z] Running install step. 03:08:03 INFO - Running pre-action listener: _resource_record_pre_action 03:08:03 INFO - Running main action method: install 03:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:03 INFO - Reading from file tmpfile_stdout 03:08:03 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:08:03 INFO - Reading from file tmpfile_stdout 03:08:03 INFO - Output received: 03:08:03 INFO - Usage: mozinstall [options] installer 03:08:03 INFO - Options: 03:08:03 INFO - -h, --help show this help message and exit 03:08:03 INFO - -d DEST, --destination=DEST 03:08:03 INFO - Directory to install application into. [default: 03:08:03 INFO - "/builds/slave/test"] 03:08:03 INFO - --app=APP Application being installed. [default: firefox] 03:08:03 INFO - mkdir: /builds/slave/test/build/application 03:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:08:38 INFO - Reading from file tmpfile_stdout 03:08:38 INFO - Output received: 03:08:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:08:38 INFO - Running post-action listener: _resource_record_post_action 03:08:38 INFO - [mozharness: 2016-09-22 10:08:38.473107Z] Finished install step (success) 03:08:38 INFO - [mozharness: 2016-09-22 10:08:38.473249Z] Running run-tests step. 03:08:38 INFO - Running pre-action listener: _resource_record_pre_action 03:08:38 INFO - Running main action method: run_tests 03:08:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:38 INFO - 2016-09-22 03:08:38.487 screenresolution[1645:8128] starting screenresolution argv=screenresolution get 03:08:38 INFO - 2016-09-22 03:08:38.490 screenresolution[1645:8128] Display 0: 1600x1200x32@60 03:08:38 INFO - 2016-09-22 03:08:38.496 screenresolution[1646:8131] starting screenresolution argv=screenresolution list 03:08:38 INFO - Available Modes on Display 0 03:08:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:38 INFO - Intel Iris: 03:08:38 INFO - Chipset Model: Intel Iris 03:08:38 INFO - Type: GPU 03:08:38 INFO - Bus: Built-In 03:08:38 INFO - VRAM (Dynamic, Max): 1536 MB 03:08:38 INFO - Vendor: Intel (0x8086) 03:08:38 INFO - Device ID: 0x0a2e 03:08:38 INFO - Revision ID: 0x0009 03:08:38 INFO - Displays: 03:08:38 INFO - Display: 03:08:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:38 INFO - Display Serial Number: 1600x1200 60 03:08:38 INFO - Main Display: Yes 03:08:38 INFO - Mirror: Off 03:08:38 INFO - Online: Yes 03:08:38 INFO - Rotation: Supported 03:08:38 INFO - Return code: 0 03:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:08:38 INFO - Python 2.7.3 03:08:38 INFO - Return code: 0 03:08:38 INFO - grabbing minidump binary from tooltool 03:08: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')]} 03:08:38 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 0x1015e1d30>, '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 0x101407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:08:38 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 03:08:38 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 03:08:38 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 03:08:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:08:38 INFO - Return code: 0 03:08:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:08:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:08:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:08:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:08:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 03:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 03:08:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hpONUwXW1P/Render', 03:08:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:38 INFO - 'HOME': '/Users/cltbld', 03:08:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:38 INFO - 'LOGNAME': 'cltbld', 03:08:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:08:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:38 INFO - 'MOZ_NO_REMOTE': '1', 03:08:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:08:38 INFO - 'NO_EM_RESTART': '1', 03:08:38 INFO - 'PAGER': '/bin/cat', 03:08:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:38 INFO - 'PWD': '/builds/slave/test', 03:08:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:08:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:38 INFO - 'SHELL': '/bin/bash', 03:08:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ox2pnjLqad/Listeners', 03:08:38 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 03:08:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:38 INFO - 'USER': 'cltbld', 03:08:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:38 INFO - 'XPC_FLAGS': '0x0', 03:08:38 INFO - 'XPC_SERVICE_NAME': '0', 03:08:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 03:08:39 INFO - mozversion application_buildid: 20160922012659 03:08:39 INFO - mozversion application_changeset: 28a35f4aa671e246cce2b9920da3a482724210b7 03:08:39 INFO - mozversion application_display_name: Nightly 03:08:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:08:39 INFO - mozversion application_name: Firefox 03:08:39 INFO - mozversion application_remotingname: firefox 03:08:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:08:39 INFO - mozversion application_vendor: Mozilla 03:08:39 INFO - mozversion application_version: 52.0a1 03:08:39 INFO - mozversion platform_buildid: 20160922012659 03:08:39 INFO - mozversion platform_changeset: 28a35f4aa671e246cce2b9920da3a482724210b7 03:08:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:08:39 INFO - mozversion platform_version: 52.0a1 03:08:39 INFO - using testdate: 1474538919 03:08:39 INFO - actual date: 1474538919 03:08:39 INFO - starting webserver on 'localhost:49267' 03:08:39 INFO - SUITE-START | Running 2 tests 03:08:39 INFO - TEST-START | dromaeo_css 03:08:39 INFO - operating with platform_type : mac_ 03:08:39 INFO - Initialising browser for dromaeo_css test... 03:08:39 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmplav7Vc/profile http://localhost:49267/getInfo.html) 03:08:41 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 03:08:41 INFO - PROCESS | 1656 | colorDepth:24 03:08:41 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 03:08:41 INFO - PROCESS | 1656 | __metrics 03:08:41 INFO - PROCESS | 1656 | 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" 03:08:41 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:42 INFO - TEST-INFO | 1656: exit 0 03:08:42 INFO - Browser initialized. 03:08:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:08:42 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmplav7Vc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:54 INFO - PROCESS | 1659 | RSS: Main: 235384832 03:08:54 INFO - PROCESS | 1659 | 03:09:45 INFO - PROCESS | 1659 | 1474538985333 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] 03:11:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 03:11:58 INFO - PROCESS | 1659 | RSS: Main: 392757248 03:11:58 INFO - PROCESS | 1659 | 03:15:02 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 03:15:02 INFO - PROCESS | 1659 | RSS: Main: 383684608 03:15:02 INFO - PROCESS | 1659 | 03:18:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 03:18:05 INFO - PROCESS | 1659 | RSS: Main: 339873792 03:18:05 INFO - PROCESS | 1659 | 03:21:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 03:21:08 INFO - PROCESS | 1659 | RSS: Main: 344076288 03:21:08 INFO - PROCESS | 1659 | 03:24:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 03:24:12 INFO - PROCESS | 1659 | RSS: Main: 332460032 03:24:12 INFO - PROCESS | 1659 | 03:27:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 03:27:16 INFO - PROCESS | 1659 | RSS: Main: 495583232 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | __start_tp_report 03:27:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 03:27:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 03:27:16 INFO - PROCESS | 1659 | |i|pagename|runs| 03:27:16 INFO - PROCESS | 1659 | |0;dojo.html;2994.8203107813533;3309.3381323735252;3317.850696718646;3343.5319055332243;3380.577427821522;5490.3411590609085;5558.555315574749;5587.078132108198;5654.547636189101;5661.490465858077;5576.33084029916;5583.357913839899;5613.550915926727;5633.6338138021;5703.800366987156;5154.793808247666;5189.558887494568;5196.610254230938;5229.058769421503;5239.318888544484;5149.485051494839;5262.05283049051;5279.128943724281;5286.154215325549;5289.418164001957;5311.282976798141;5313.867153321159;5344.7862085516535;5356;5362.51737343639;5095.745212739348;5244.92132618013;5251.894962100775;5270.367555893317;5301.575873930076;5086.135356989321;5127.589792816603;5164.096283150434;5180.922286165711;5194.558462530689;5521.751521181556;5522.944770552283;5560.749766260528;5658.292713410824;5728.68492232927;6147.754089836401;6153.169322141498;6164.7534098636;6169.845753856144;6175.104609831594;4994.775235114428;6092.786752463642;6104.246950856121;6227.813165605039;6246.968765156191;5555.388907220203;5571;5577.693226872561;5611.382747897728;5654.151877218368;6217.813465595949;6231.626102433868;6232.407921247474;6238.968805156036;6246.593971391845;5874.794382196603;5878.882422351529;5892;5904.9704751475965;5921.052631579013;6094.2077529920825;6112.625067133501;6141.087130295746;6155.84610384735;6157.96921015392;6143.96928015357;6161.260648722093;6176.938230617726;6197.938020619827;6203.16257305267;6121.755129794848;6169.56813023093;6230.844228894223;6240.095186198067;6247.406496382927;4805.711657300573;4841.685290456109;4844.370231869834;4851.902961940741;4937.555619994146;4369.541198174146;4378.78106094694;4386.846460373871;4474.127545128734;4478;5695.572832037614;5700.059490184073;5710.885782284331;5713.114467257582;5757.827265182052;6073.331933487313;6112.625067133501;6242.375762423721;6247.718852651642;6275.341089185661;5665.943340566541;5678.602497825113;5683.26117604717;5700.40145784695;5793.507551858055;5351.812686555952;5390.056740070472;5396.487333703292;5401.405845357008;5409.107497262908;6331.113644089739;6341.746330146835;6350.523710721714;6352.523560732963;6364.64994425311;6030.276366836008;6090.969545152246;6095.817125486243;6183.907241391293;6198.907016394667;6224.097505861715;6267.780627678009;6280.7487700491465;6283.7800676976085;6315.431611155018;6081.908771368345;6125.418085281891;6130.816075517741;6140.232470941132;6144.078388241799;6232.688365581612;6238.313785483684;6251.906221406592;6253.437190652863;6258.749650014131;5653.660780353192;5848.912266316093;5871.412858714094;5978.671173085348;6004.249468816398;6061.272647282178;6070.362611925684;6083.087536869505;6105.9694701526205;6137.815865524041;5844.094165404369;5881.882362352643;5909.852253693692;5911.379305173067;5912.024515954819;5891.528677705859;5930.970345148246;5997.520198384032;6005.309389420273;6032.939670603238;5896.941030589639;5908.556858235564;5909.940900590939;5930.495907847881;5940.227770389822 03:27:16 INFO - PROCESS | 1659 | |1;ext.html;488.1628007966337;490.1569300802618;519.1900635009385;521.4342438454278;525.561156434377;25727.871360643196;30162.84918575407;31699.68300316999;31705.207369815766;31750.841245793796;40799;41631.79184104075;42592.361114583306;43957.12085758291;44012.3398149028;9630.518474076303;9817.312788104835;9827.410355378664;9830.508474576278;9832.950835245814;8840.778980525507;9698.563564639573;9796.363236389612;9804.117629413351;9804.901950980506;8838.823223535526;12021.579244726436;12249.265044097383;12251.816222756666;12486.375681215948;12221;12290.20113692607;12295.877041229607;12313.815292770616;12326.952209062241;11995.700107497296;12056.517739290417;12061;12077.758444831143;12089.818652720129;39482.60517394818;39675.20649587021;39714.80855574337;39744.00639984023;39761.80119099415;3289.473684210515;3310.8344582771006;3332.933341333184;3370.561826962504;3468.1156305142026;29951.700482995107;30705.539416908763;30966.72282013725;32099.6790032099;32100.03699889007;3332.566766320387;3338.532605435241;3372.64587218341;3426.811525366104;3433.2790114076074;509104.36269461154;514835;519445.8055419473;520953;521285;34051.14872128217;34739.652603473645;63985;64720.67639661772;64917.67541162264;35516.82241588776;35540.46689299663;35709;35742.821285893406;35754.64245357513;14526;14662.486812961495;14686.706265874836;14696.853031469762;14707.191104489355;12310.75378492425;12414.56549020798;12440.875591243972;12445.439955201857;12450.937745311216;7349.228331025272;7485.85028299431;7759.57322347265;7802.102758182768;7872.685092596346;3287.1946373138258;3356.6139893912514;3367.831608419618;3371.190914180579;3397.5583174187195;847.6100993543039;935.3312381647155;959.7696552827272;993.9950300248453;1027.9331843430152;28888.566671499946;29808.552871706943;29906.55140172899;30686.69313306883;30694.53958190629;974.8934958821789;1032.5921261101823;1040.7502199472224;1097.8408130820985;1118.3122379736403;11999.100067494974;15976.680466390608;16312.265948032367;16386.344546218257;17078;711514;967405;987574;989267;990425;49887.00225995533;50227.24659130116;57453.42546574564;58283;58328.416715832296;1155.5782139519183;1222.1506053292876;1240.1814802230665;1244.1850587864963;1248.2136254160002;29139.12582622525;30409.847950760104;30612.846935765177;30743.71743832368;30883.38233235278;48634.54096377114;49280.260796088805;49300.2604960933;49331.75334123307;49381.506184937694;562261;567442;568664;569433;571881.7029574293;23524.411889702893;26587.601185982614;27328.453430930873;27405.72594274032;28175.43649126965;46129.538704613864;46169.76915115403;46512.30231546462;46631.76684116694;46816.7659161702;37446;37515.62484375121;39129.804350979204;39859;41263.11158218896;37359.626403735616;37921.81039094897;37994.620053800216;38845.80577097096;39316.80341598274;37715.81142094272;38003;38493;38506.229875402896;38568.61431385762;32345.676543234265;33499;34204.14489637779;34297.142571435914;34415.65584344124;25171.622425663263;25250.494990100462;25385.492290153725;25461;26069.217923462325 03:27:16 INFO - PROCESS | 1659 | |2;jquery.html;356.90185199070237;369.12885590007596;379.83856860834146;384.4195265149625;402.9939550906735;15031.473898413544;15256.694866102685;17030.914845425785;20446.795532044674;20879.197644828117;16645.66708665826;19595.804041959575;19693.21227150912;20217.49456263594;20454.284100056502;5763.711814409273;5810.506106980912;5949.375315591866;5960.463558279754;5978.641281523101;5660.886782264352;5804.941950580483;5859.150423188635;5859.619124756899;5865.149553314767;4120.711550191488;4328.870133895973;5126.538611524962;5846.2107615472005;6507.4143327100555;6263.812085637438;6553.6395498247575;6575.736970521173;6578.572392794453;6583.177102862166;5582.330120385539;5635.661860288355;5640.661560306354;5644;5645.717714114319;20445.591088178153;22453.877306134793;23993.40016499584;25276.034475023414;25452.872735636203;2192.4190089626263;2260.2541161416857;2274.613315736329;2308.203669733939;2394.1261439574605;9586.041395860428;15383.538493845203;15532.844671553366;15670;15735.291911863993;1615.4507467461003;1819.1813683842324;1901.91441385138;1931.1020375525447;1958.3341663834365;117600;119429.84846288076;121958.39020804928;130104;130235;9918.908920018792;10411.802642696186;11221.495032723547;11299.548018079186;11508.654740357802;13932.93033534826;14307.21310327942;14338.139711617336;14342.498012569718;14345.713085738227;7060;8277.461964972257;8443.577821109044;8519.872201916976;8526.360522960678;8402.915970840335;8404.8319033619;8413.663453461915;8582;8610.225079742853;3871.9605109988524;3891.494105766232;3918.863529576448;4384.101259241847;4455.287154055336;1582.5489735425579;1667.8658512211812;1826.2603645523584;1829.8627602929832;1921.8558608104167;767.9539227646247;898.389095415124;906.7325139083986;925.1904583489446;955.6464108279981;20430.387088387073;20546.69179962302;21161.624494407813;21670.241541546286;21706.891465542572;908.9091090890857;916.3265000224962;920.346553946692;988.7182153086479;991.1575161112996;9245.583948722324;10549.789004220027;10843.83734243987;11294;11360.318380897008;553974;557309;579967;591313;592340;109701;123958;125702.48595028048;126896;128248;983.6163896080391;984.6602921991902;1025.733309339577;1047.659510659039;1050.6060227414719;18789.96655183978;19562;19661.705074423608;19667.70498442496;19694.310699126036;55567;57058;57486;57632.135517966424;58168.12747808871;80181.5990920065;80989.19010810052;81770;81985.59007204926;83031;7059.258777828254;7397.334239918433;7970.97103100818;7988.132031153418;8277.875831862648;9154.908450915673;11835.763284734085;12379.257244565355;12471.189372690746;13231.40458679381;10562.260641755003;10805.783884322112;11776.470058847544;11832.99419549348;11866.228695134789;10865.076468500267;11068.501917413896;11348.262362946381;11625.6512304631;11638;10998.230123891251;11516.30902145874;11540.307581545134;11739.589114380955;11993.34036627959;7059.682314295972;7269.709211631687;7325.157606875065;8098.271155596025;8155.755327340189;10525.89474105249;11409;11584.247023943753;11785.764284714429;11802.055835533309 03:27:16 INFO - PROCESS | 1659 | |3;mootools.html;1341.336038660863;1357.0432844844386;1515.3938424630146;1664.267722202231;1906.475719177226;7457.25427457254;7912.604369781517;8622.439541429803;8855.158759917813;8856.822863542742;8697.608607612658;8796.868046979285;8801.98777140629;8810.163034511712;8814.735557933256;2377.9286621401384;2409.6024156014237;2411.963820542693;2412.264259400882;2413.2880800163907;2298.6666933294746;2340;2347.0494449747794;2348.5537747827943;2350.7061617297836;2361.138184562631;2377.6433534969806;2391.5336509380677;2398.412388964706;2407.6268178432283;1910.5414700471927;2298.2186056740707;2303.7235531736214;2304.4699719064542;2317.6523521471745;2349.189529612281;2355.4346956730433;2357.1867705641525;2357.316378250305;2358.8348815582917;8732.987119443782;8776.254018408443;8847.823043539158;8855.070217627184;8880.8667869982;5195.090859099642;5385.407605163429;5387.4073851876265;5396.892062158735;5400.513953744143;3457.9827100864586;3613.7470377073614;3660.816959152058;3685.0603096210293;3685.2261025184744;1065.2915810985685;1098.7692584557253;1100.983485247722;1121.4224674292745;1124.0501775999348;11761.529538818437;11766.11754118436;11830.52677892892;11851.822222666668;11881.049516038696;4345.326474396474;4515.932261016087;4619.353290539327;4623.514530974267;4625.444946606362;9092.954535227282;9099.953505346837;9099.954500227457;9110.453372797654;9121.635134594542;4378.6278166356215;5231.450697676765;5234.450382709761;5239.554637855748;5244.763985620656;4059.817308221137;4283.657307415399;4427.446569178853;4537.274036154199;4903.41159060915;3500.1074725944723;3798.164403831153;3809.5238095238096;3866.2654095721723;3877.2051729395407;1161.802493576094;1185.3065956415594;1187.8693343732182;1194.396829601046;1196.838426812369;837.5384953256606;856.8800367948493;896.6010125494223;899.4827973915025;933.3513208320288;5763.4812866842185;5840.88318233633;6030.969845150747;6040.305364883095;6087.54343424245;890.9153630405101;931.4737173496952;939.3471537281524;957.3777044920857;972.4165500699523;3867.3425517662067;3904.6095390461296;3968;4037.313656678372;4060.553339132693;10351.327163734333;10732.141428685687;10764.623238186627;10971.451427428756;11002.779944401227;10910.127189824794;10924.781504369868;10925.508352124174;10928.743194532572;11007.889921100847;8112.351011919032;8315.334773218128;8328.375371847136;8336.499810011419;8351.039630442456;5739.483446489836;5893.970530147493;6051.517378242359;6078.3921607838865;6120.326764056039;9534.427934323963;10225.948870255601;10244.334118282288;10254.794904102026;10268.794624107626;9383.530823458936;10454.215933804842;10458.581656733646;10465;10470.685879423629;7029.753958611629;7189.532680375759;7201.423886089205;7215.134183897966;7217.6030318333;6655.900161497679;8106.959465202636;8238.382121341043;8342.541160236246;8526.78683032929;7574.015378001045;7577.810554736176;7589.962050189713;7608.771736847903;7610.961945190239;7276.7089316426745;7322.121345438582;7468.10382754073;7468.738594149178;7494.250574942462;6926.0649812276715;7076.893846592202;7083.256258093033;7083.327083927019;7083.858322833411;4785.210440277316;4826.61387089025;5004.199328107486;5038.546530812245;5241.9737901310245;5114.3862736471865;5140.581513293768;5146.716930568855;5190.574330196499;5257.658252213747 03:27:16 INFO - PROCESS | 1659 | |4;prototype.html;300.8480717237795;301.73447366317635;309.71506214282863;316.07863079124354;317.20065435103527;5110.361204849394;5144.485551444854;5145.3825540935095;5196.688198708081;5250.291210686556;4194.916101677964;4820.46974832769;4844.418669759634;5051.974740126294;5208.583313334933;3809.8857034289017;3906.8437262509465;3927.3323534998976;3932.803359832011;3943.487346644932;3280.114369120336;3280.9343813123724;3513.806740629277;3661.9084522886874;4015.4579131817122;2953.862762836313;3703.2038111805955;3735.570409402926;3751.8499260029566;3932.0563064864514;3711.517502724642;3915.6897430516133;3949.328614135604;3972.9006774830714;3992.201559688074;3447.1382154461385;3457.6888080072663;3460.4290292101773;3463.203463203452;3475.6966137698364;4941.703497790144;4995.602110986747;4998.6750861193905;5002.374703162105;5008.223725322581;4069.8168582413864;4341.826326946918;4467.396901418299;4557.4986751457645;4567.314902764579;5465.945340546623;5476.726163691839;5477.507024367826;5483.561315094783;5502.339719233718;3462.7056700180515;3618.8009659468717;3831.942520862189;3834.156485573197;3841.308564458396;5437.374701909292;5522.585806064561;5624.131692836682;5639.2668953035845;5757.625754325997;3186.984065079706;3265.248992731685;3837.4052021936645;3844.7308688392104;3846.1346197105427;3939.350007248772;3941.842326306973;3942.72400931932;3943.7042221833476;3961.3463778476803;4335.653147748172;4510.774461276923;4518.4126063612175;4523.629895727704;4546.840860569864;4200.894977625584;4774.689645173053;4868.859585567289;5265.236540701577;5380.229181971288;1063.9521221544894;1336.8863646589955;1337.81270622113;1339.9799003014768;1343;813.7314686153555;842.3850589070013;864;874.7157173918501;887.9289656827439;4792.764883703486;4933.28467372229;4996.4503904570465;5006.824761133415;5011.4236862761245;5028.069807085701;5436.401995780461;5454.509094181463;5458.945410545924;5483.341998960151;4208.284591619432;4470.413003383817;4717.056588682209;4720.362751028636;4999.500049994971;2859.242300790292;2864.7278508541654;2883.5098033334384;2886.7979241452895;2893.2911436698146;4477.888052798706;4897.853064408074;5638.984982703071;5750.741216645261;5811.4479124483105;4906.705597664151;5307.495787900143;5680.829575112753;5747.741351639186;5787.681677507778;5248.3701955765555;5502.614816962854;5870.26621672291;5874;5878.206442130343;4364.381371177268;4603.010352774169;5127.846304552172;5444.3194600674915;5649.971750141223;4678.649101317483;5484;5511.614187006871;5533.395315358501;5558;4841.394825646794;5692.861427714391;5833.854153646023;5892.882142357214;5922.585419020627;3585.300866331145;3756.305083559441;3782.93829862731;3795.9620403795607;3796.7152463565894;5504.981578408007;5537.197106419466;5566.332040155045;5568.63568425722;5586.217929489956;4604.539546045368;5414.242006119068;5421.132618780976;5445.727713614383;5498.367687715804;5265.97260054874;5317.989581979412;5445.537129343892;5449.746558291536;5509.311336082989;4560.703554268962;5058.924116138187;5174.301469301596;5311.946880531145;5334.839954801362;5149.330587023663;5319.361676598678;5340.519353258225;5345.679259244303;5465.890682186255;4171.749695018188;5295.205719142159;5339.359276886798;5367.3827509836865;5373.865653358541 03:27:16 INFO - PROCESS | 1659 | |5;yui.html;713.5540287320425;719.0544434069199;760.6691089376122;811.6266517401993;814.7107776739253;15608;16172.514824555254;16185;16200.918995405036;16202.108884011375;14461.63845903853;14600.926995365035;14606.050606710556;14620.926895365508;14643.487477938274;675.9662016899135;696.0151385789102;824.756696774453;831.7089018843417;853.9914600853974;819.7499762572413;829.4691397505601;831.268483734313;831.6257684042205;834.8539005674013;880.7401816464127;881.2157180109707;883.4655033704613;884.9026607073217;884.9734507964771;873.720409468967;874.956252187388;876.8860048193726;877.3507604372782;878.0341624213378;524.1299442924727;526.9683818970835;545.3564793543617;666.6566718140161;668.8929771236627;14595.927020364936;14624.341904614317;14637.341319640642;14639.902007349385;14644;13509.189448633113;14037.719245615133;14053;14057.297135143304;14402.423903043866;12218.938905305506;12501.249925004438;12583.685407864785;12599.3070381129;12935.87064129356;4487.214737420938;4503.459584849807;4584.4957054723955;4693.78877950493;4712.269598212282;69405.65297173482;91189.54405227998;118692.40653796762;119674.80325196724;122906.38546807299;10181.134603558781;10209.846852297072;10232.130268927076;10254.743956329596;10343.896561034293;21391.930403479764;21438;21620.243291485036;21649.783502165094;21708.240211592518;7915.485493443023;8018.438709290411;8032.196780321921;8090.069641991128;8120.472169308976;4292.506361768436;4399.6040356368085;4416.4258646375765;4435.848613422488;4527.660425468103;3612.169201083713;3764.0401697566945;3765.811709414573;3771.245750849841;3771.9811400943368;684.2131548719013;693.0539813155007;698.9650517474106;699.0283505926766;704.0882057735245;618.783425800966;666.7699643622942;669.8928171492636;672.7140965089817;703.8345988692653;8907.198352148338;9311;9493.382930109521;9608.855867161998;9723.270754693427;628.7967072475303;645.8901986662279;654.2476152424749;671.3582054615105;683.3098570443888;4629.398178236807;4656.767161641905;4663.207254766698;4676.321933319649;4776.880577985578;94170.52914735382;122603;123269;126824;130943;117399;120629;120738;121611.39194303972;124266;100114.4994275024;100941;103670;106832.46583767187;107441;9271.211946984313;9830.213582913493;9861.457619830979;9952.950235248778;9977.60089596408;48099.75950120227;55147.72426138004;61294.774104518554;62929;64217.678911605144;78836.60581697055;82614.17385826065;83209.75185372346;84398.57800710957;90847;12913.289769062792;13148.539801106916;13202.735945281232;13253.271070090852;13561;14535.27323633793;14693.55919322422;14946.701065978403;14989.400423983354;15176.620584485476;13428.261445620585;13868.375923083284;13901.791473127709;13933.23367214813;14312.355943982753;13529.661758456117;13756.793648095487;13812;13923.791143133063;14122;13339.866601333862;13521.86478135206;13535.483420802168;13538.661533461742;13825.308734563432;10917.290376125526;11309.71725706831;11477.208960486036;11478.253913495597;11572.24780389272;10693.572257109628;11343.262687925258;11488.195826292414;11621.070314374661;11622.883771162518 03:27:16 INFO - PROCESS | 1659 | __end_tp_report 03:27:16 INFO - PROCESS | 1659 | __start_cc_report 03:27:16 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1489 03:27:16 INFO - PROCESS | 1659 | __end_cc_report 03:27:16 INFO - PROCESS | 1659 | __startTimestamp1474540036055__endTimestamp 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | ------- Summary: start ------- 03:27:16 INFO - PROCESS | 1659 | Number of tests: 6 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5688.37 Median:5881.88 stddev:630.79 (10.7%) stddev-sans-first:596.28 03:27:16 INFO - PROCESS | 1659 | Values: 2994.8 3309.3 3317.9 3343.5 3380.6 5490.3 5558.6 5587.1 5654.5 5661.5 5576.3 5583.4 5613.6 5633.6 5703.8 5154.8 5189.6 5196.6 5229.1 5239.3 5149.5 5262.1 5279.1 5286.2 5289.4 5311.3 5313.9 5344.8 5356.0 5362.5 5095.7 5244.9 5251.9 5270.4 5301.6 5086.1 5127.6 5164.1 5180.9 5194.6 5521.8 5522.9 5560.7 5658.3 5728.7 6147.8 6153.2 6164.8 6169.8 6175.1 4994.8 6092.8 6104.2 6227.8 6247.0 5555.4 5571.0 5577.7 5611.4 5654.2 6217.8 6231.6 6232.4 6239.0 6246.6 5874.8 5878.9 5892.0 5905.0 5921.1 6094.2 6112.6 6141.1 6155.8 6158.0 6144.0 6161.3 6176.9 6197.9 6203.2 6121.8 6169.6 6230.8 6240.1 6247.4 4805.7 4841.7 4844.4 4851.9 4937.6 4369.5 4378.8 4386.8 4474.1 4478.0 5695.6 5700.1 5710.9 5713.1 5757.8 6073.3 6112.6 6242.4 6247.7 6275.3 5665.9 5678.6 5683.3 5700.4 5793.5 5351.8 5390.1 5396.5 5401.4 5409.1 6331.1 6341.7 6350.5 6352.5 6364.6 6030.3 6091.0 6095.8 6183.9 6198.9 6224.1 6267.8 6280.7 6283.8 6315.4 6081.9 6125.4 6130.8 6140.2 6144.1 6232.7 6238.3 6251.9 6253.4 6258.7 5653.7 5848.9 5871.4 5978.7 6004.2 6061.3 6070.4 6083.1 6106.0 6137.8 5844.1 5881.9 5909.9 5911.4 5912.0 5891.5 5931.0 5997.5 6005.3 6032.9 5896.9 5908.6 5909.9 5930.5 5940.2 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:77158.74 Median:35128.24 stddev:188963.02 (537.9%) stddev-sans-first:189405.43 03:27:16 INFO - PROCESS | 1659 | Values: 488.2 490.2 519.2 521.4 525.6 25727.9 30162.8 31699.7 31705.2 31750.8 40799.0 41631.8 42592.4 43957.1 44012.3 9630.5 9817.3 9827.4 9830.5 9833.0 8840.8 9698.6 9796.4 9804.1 9804.9 8838.8 12021.6 12249.3 12251.8 12486.4 12221.0 12290.2 12295.9 12313.8 12327.0 11995.7 12056.5 12061.0 12077.8 12089.8 39482.6 39675.2 39714.8 39744.0 39761.8 3289.5 3310.8 3332.9 3370.6 3468.1 29951.7 30705.5 30966.7 32099.7 32100.0 3332.6 3338.5 3372.6 3426.8 3433.3 509104.4 514835.0 519445.8 520953.0 521285.0 34051.1 34739.7 63985.0 64720.7 64917.7 35516.8 35540.5 35709.0 35742.8 35754.6 14526.0 14662.5 14686.7 14696.9 14707.2 12310.8 12414.6 12440.9 12445.4 12450.9 7349.2 7485.9 7759.6 7802.1 7872.7 3287.2 3356.6 3367.8 3371.2 3397.6 847.6 935.3 959.8 994.0 1027.9 28888.6 29808.6 29906.6 30686.7 30694.5 974.9 1032.6 1040.8 1097.8 1118.3 11999.1 15976.7 16312.3 16386.3 17078.0 711514.0 967405.0 987574.0 989267.0 990425.0 49887.0 50227.2 57453.4 58283.0 58328.4 1155.6 1222.2 1240.2 1244.2 1248.2 29139.1 30409.8 30612.8 30743.7 30883.4 48634.5 49280.3 49300.3 49331.8 49381.5 562261.0 567442.0 568664.0 569433.0 571881.7 23524.4 26587.6 27328.5 27405.7 28175.4 46129.5 46169.8 46512.3 46631.8 46816.8 37446.0 37515.6 39129.8 39859.0 41263.1 37359.6 37921.8 37994.6 38845.8 39316.8 37715.8 38003.0 38493.0 38506.2 38568.6 32345.7 33499.0 34204.1 34297.1 34415.7 25171.6 25250.5 25385.5 25461.0 26069.2 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34542.85 Median:13193.76 stddev:96331.42 (730.1%) stddev-sans-first:96567.45 03:27:16 INFO - PROCESS | 1659 | Values: 356.9 369.1 379.8 384.4 403.0 15031.5 15256.7 17030.9 20446.8 20879.2 16645.7 19595.8 19693.2 20217.5 20454.3 5763.7 5810.5 5949.4 5960.5 5978.6 5660.9 5804.9 5859.2 5859.6 5865.1 4120.7 4328.9 5126.5 5846.2 6507.4 6263.8 6553.6 6575.7 6578.6 6583.2 5582.3 5635.7 5640.7 5644.0 5645.7 20445.6 22453.9 23993.4 25276.0 25452.9 2192.4 2260.3 2274.6 2308.2 2394.1 9586.0 15383.5 15532.8 15670.0 15735.3 1615.5 1819.2 1901.9 1931.1 1958.3 117600.0 119429.8 121958.4 130104.0 130235.0 9918.9 10411.8 11221.5 11299.5 11508.7 13932.9 14307.2 14338.1 14342.5 14345.7 7060.0 8277.5 8443.6 8519.9 8526.4 8402.9 8404.8 8413.7 8582.0 8610.2 3872.0 3891.5 3918.9 4384.1 4455.3 1582.5 1667.9 1826.3 1829.9 1921.9 768.0 898.4 906.7 925.2 955.6 20430.4 20546.7 21161.6 21670.2 21706.9 908.9 916.3 920.3 988.7 991.2 9245.6 10549.8 10843.8 11294.0 11360.3 553974.0 557309.0 579967.0 591313.0 592340.0 109701.0 123958.0 125702.5 126896.0 128248.0 983.6 984.7 1025.7 1047.7 1050.6 18790.0 19562.0 19661.7 19667.7 19694.3 55567.0 57058.0 57486.0 57632.1 58168.1 80181.6 80989.2 81770.0 81985.6 83031.0 7059.3 7397.3 7971.0 7988.1 8277.9 9154.9 11835.8 12379.3 12471.2 13231.4 10562.3 10805.8 11776.5 11833.0 11866.2 10865.1 11068.5 11348.3 11625.7 11638.0 10998.2 11516.3 11540.3 11739.6 11993.3 7059.7 7269.7 7325.2 8098.3 8155.8 10525.9 11409.0 11584.2 11785.8 11802.1 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5684.13 Median:4953.81 stddev:3208.90 (64.8%) stddev-sans-first:3201.30 03:27:16 INFO - PROCESS | 1659 | Values: 1341.3 1357.0 1515.4 1664.3 1906.5 7457.3 7912.6 8622.4 8855.2 8856.8 8697.6 8796.9 8802.0 8810.2 8814.7 2377.9 2409.6 2412.0 2412.3 2413.3 2298.7 2340.0 2347.0 2348.6 2350.7 2361.1 2377.6 2391.5 2398.4 2407.6 1910.5 2298.2 2303.7 2304.5 2317.7 2349.2 2355.4 2357.2 2357.3 2358.8 8733.0 8776.3 8847.8 8855.1 8880.9 5195.1 5385.4 5387.4 5396.9 5400.5 3458.0 3613.7 3660.8 3685.1 3685.2 1065.3 1098.8 1101.0 1121.4 1124.1 11761.5 11766.1 11830.5 11851.8 11881.0 4345.3 4515.9 4619.4 4623.5 4625.4 9093.0 9100.0 9100.0 9110.5 9121.6 4378.6 5231.5 5234.5 5239.6 5244.8 4059.8 4283.7 4427.4 4537.3 4903.4 3500.1 3798.2 3809.5 3866.3 3877.2 1161.8 1185.3 1187.9 1194.4 1196.8 837.5 856.9 896.6 899.5 933.4 5763.5 5840.9 6031.0 6040.3 6087.5 890.9 931.5 939.3 957.4 972.4 3867.3 3904.6 3968.0 4037.3 4060.6 10351.3 10732.1 10764.6 10971.5 11002.8 10910.1 10924.8 10925.5 10928.7 11007.9 8112.4 8315.3 8328.4 8336.5 8351.0 5739.5 5894.0 6051.5 6078.4 6120.3 9534.4 10225.9 10244.3 10254.8 10268.8 9383.5 10454.2 10458.6 10465.0 10470.7 7029.8 7189.5 7201.4 7215.1 7217.6 6655.9 8107.0 8238.4 8342.5 8526.8 7574.0 7577.8 7590.0 7608.8 7611.0 7276.7 7322.1 7468.1 7468.7 7494.3 6926.1 7076.9 7083.3 7083.3 7083.9 4785.2 4826.6 5004.2 5038.5 5242.0 5114.4 5140.6 5146.7 5190.6 5257.7 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4383.67 Median:4920.00 stddev:1343.84 (27.3%) stddev-sans-first:1312.20 03:27:16 INFO - PROCESS | 1659 | Values: 300.8 301.7 309.7 316.1 317.2 5110.4 5144.5 5145.4 5196.7 5250.3 4194.9 4820.5 4844.4 5052.0 5208.6 3809.9 3906.8 3927.3 3932.8 3943.5 3280.1 3280.9 3513.8 3661.9 4015.5 2953.9 3703.2 3735.6 3751.8 3932.1 3711.5 3915.7 3949.3 3972.9 3992.2 3447.1 3457.7 3460.4 3463.2 3475.7 4941.7 4995.6 4998.7 5002.4 5008.2 4069.8 4341.8 4467.4 4557.5 4567.3 5465.9 5476.7 5477.5 5483.6 5502.3 3462.7 3618.8 3831.9 3834.2 3841.3 5437.4 5522.6 5624.1 5639.3 5757.6 3187.0 3265.2 3837.4 3844.7 3846.1 3939.4 3941.8 3942.7 3943.7 3961.3 4335.7 4510.8 4518.4 4523.6 4546.8 4200.9 4774.7 4868.9 5265.2 5380.2 1064.0 1336.9 1337.8 1340.0 1343.0 813.7 842.4 864.0 874.7 887.9 4792.8 4933.3 4996.5 5006.8 5011.4 5028.1 5436.4 5454.5 5458.9 5483.3 4208.3 4470.4 4717.1 4720.4 4999.5 2859.2 2864.7 2883.5 2886.8 2893.3 4477.9 4897.9 5639.0 5750.7 5811.4 4906.7 5307.5 5680.8 5747.7 5787.7 5248.4 5502.6 5870.3 5874.0 5878.2 4364.4 4603.0 5127.8 5444.3 5650.0 4678.6 5484.0 5511.6 5533.4 5558.0 4841.4 5692.9 5833.9 5892.9 5922.6 3585.3 3756.3 3782.9 3796.0 3796.7 5505.0 5537.2 5566.3 5568.6 5586.2 4604.5 5414.2 5421.1 5445.7 5498.4 5266.0 5318.0 5445.5 5449.7 5509.3 4560.7 5058.9 5174.3 5311.9 5334.8 5149.3 5319.4 5340.5 5345.7 5465.9 4171.7 5295.2 5339.4 5367.4 5373.9 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:23280.60 Median:3771.61 stddev:35597.07 (943.8%) stddev-sans-first:35656.60 03:27:16 INFO - PROCESS | 1659 | Values: 713.6 719.1 760.7 811.6 814.7 15608.0 16172.5 16185.0 16200.9 16202.1 14461.6 14600.9 14606.1 14620.9 14643.5 676.0 696.0 824.8 831.7 854.0 819.7 829.5 831.3 831.6 834.9 880.7 881.2 883.5 884.9 885.0 873.7 875.0 876.9 877.4 878.0 524.1 527.0 545.4 666.7 668.9 14595.9 14624.3 14637.3 14639.9 14644.0 13509.2 14037.7 14053.0 14057.3 14402.4 12218.9 12501.2 12583.7 12599.3 12935.9 4487.2 4503.5 4584.5 4693.8 4712.3 69405.7 91189.5 118692.4 119674.8 122906.4 10181.1 10209.8 10232.1 10254.7 10343.9 21391.9 21438.0 21620.2 21649.8 21708.2 7915.5 8018.4 8032.2 8090.1 8120.5 4292.5 4399.6 4416.4 4435.8 4527.7 3612.2 3764.0 3765.8 3771.2 3772.0 684.2 693.1 699.0 699.0 704.1 618.8 666.8 669.9 672.7 703.8 8907.2 9311.0 9493.4 9608.9 9723.3 628.8 645.9 654.2 671.4 683.3 4629.4 4656.8 4663.2 4676.3 4776.9 94170.5 122603.0 123269.0 126824.0 130943.0 117399.0 120629.0 120738.0 121611.4 124266.0 100114.5 100941.0 103670.0 106832.5 107441.0 9271.2 9830.2 9861.5 9953.0 9977.6 48099.8 55147.7 61294.8 62929.0 64217.7 78836.6 82614.2 83209.8 84398.6 90847.0 12913.3 13148.5 13202.7 13253.3 13561.0 14535.3 14693.6 14946.7 14989.4 15176.6 13428.3 13868.4 13901.8 13933.2 14312.4 13529.7 13756.8 13812.0 13923.8 14122.0 13339.9 13521.9 13535.5 13538.7 13825.3 10917.3 11309.7 11477.2 11478.3 11572.2 10693.6 11343.3 11488.2 11621.1 11622.9 03:27:16 INFO - PROCESS | 1659 | -------- Summary: end -------- 03:27:16 INFO - PROCESS | 1659 | 03:27:16 INFO - TEST-INFO | 1659: exit 0 03:27:16 INFO - TEST-OK | dromaeo_css | took 1117626ms 03:27:16 INFO - TEST-START | kraken 03:27:16 INFO - operating with platform_type : mac_ 03:27:16 INFO - Initialising browser for kraken test... 03:27:16 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp6uUIW0/profile http://localhost:49267/getInfo.html) 03:27:19 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 03:27:19 INFO - PROCESS | 1664 | colorDepth:24 03:27:19 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 03:27:19 INFO - PROCESS | 1664 | __metrics 03:27:19 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:27:19 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:27:19 INFO - TEST-INFO | 1664: exit 0 03:27:19 INFO - Browser initialized. 03:27:19 INFO - Running cycle 1/1 for kraken test... 03:27:19 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp6uUIW0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:31 INFO - PROCESS | 1665 | RSS: Main: 235335680 03:27:31 INFO - PROCESS | 1665 | 03:27:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 03:27:35 INFO - PROCESS | 1665 | RSS: Main: 293883904 03:27:35 INFO - PROCESS | 1665 | 03:27:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 03:27:38 INFO - PROCESS | 1665 | RSS: Main: 292880384 03:27:38 INFO - PROCESS | 1665 | 03:27:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 03:27:42 INFO - PROCESS | 1665 | RSS: Main: 383311872 03:27:42 INFO - PROCESS | 1665 | 03:27:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 03:27:45 INFO - PROCESS | 1665 | RSS: Main: 285298688 03:27:45 INFO - PROCESS | 1665 | 03:27:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:47 INFO - PROCESS | 1665 | RSS: Main: 290652160 03:27:47 INFO - PROCESS | 1665 | 03:27:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:51 INFO - PROCESS | 1665 | RSS: Main: 328122368 03:27:51 INFO - PROCESS | 1665 | 03:27:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:54 INFO - PROCESS | 1665 | RSS: Main: 329715712 03:27:54 INFO - PROCESS | 1665 | 03:27:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 03:27:58 INFO - PROCESS | 1665 | RSS: Main: 326631424 03:27:58 INFO - PROCESS | 1665 | 03:27:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:00 INFO - PROCESS | 1665 | RSS: Main: 299921408 03:28:00 INFO - PROCESS | 1665 | 03:28:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:02 INFO - PROCESS | 1665 | RSS: Main: 304357376 03:28:02 INFO - PROCESS | 1665 | 03:28:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:05 INFO - PROCESS | 1665 | RSS: Main: 309829632 03:28:05 INFO - PROCESS | 1665 | 03:28:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:09 INFO - PROCESS | 1665 | RSS: Main: 322056192 03:28:09 INFO - PROCESS | 1665 | 03:28:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:12 INFO - PROCESS | 1665 | RSS: Main: 318341120 03:28:12 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 03:28:14 INFO - PROCESS | 1665 | RSS: Main: 361820160 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | __start_tp_report 03:28:14 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 03:28:14 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 03:28:14 INFO - PROCESS | 1665 | |i|pagename|runs| 03:28:14 INFO - PROCESS | 1665 | |0;ai-astar;110;113;113;111;114;113;112;112;111;113 03:28:14 INFO - PROCESS | 1665 | |1;audio-beat-detection;143;109;114;176;94;128;135;136;147;107 03:28:14 INFO - PROCESS | 1665 | |2;audio-dft;182;186;184;184;184;185;179;182;181;185 03:28:14 INFO - PROCESS | 1665 | |3;audio-fft;79;59;59;88;61;59;58;59;82;58 03:28:14 INFO - PROCESS | 1665 | |4;audio-oscillator;83;69;90;70;69;69;90;67;67;88 03:28:14 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;87;85;87;85;86;83;87;83;86;85 03:28:14 INFO - PROCESS | 1665 | |6;imaging-darkroom;92;92;92;93;93;93;94;93;92;93 03:28:14 INFO - PROCESS | 1665 | |7;imaging-desaturate;84;86;87;86;86;85;86;84;86;83 03:28:14 INFO - PROCESS | 1665 | |8;json-parse-financial;55;53;52;52;53;53;54;54;53;54 03:28:14 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;73;80;74;73;71;69;69;70;75;104 03:28:14 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;85;85;85;88;86;89;86;85;86;89 03:28:14 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;140;142;150;148;138;137;140;136;181;144 03:28:14 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;168;165;163;169;170;168;167;168;168;167 03:28:14 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;68;68;68;70;70;65;67;67;67;67 03:28:14 INFO - PROCESS | 1665 | __end_tp_report 03:28:14 INFO - PROCESS | 1665 | __start_cc_report 03:28:14 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1991 03:28:14 INFO - PROCESS | 1665 | __end_cc_report 03:28:14 INFO - PROCESS | 1665 | __startTimestamp1474540094610__endTimestamp 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | ------- Summary: start ------- 03:28:14 INFO - PROCESS | 1665 | Number of tests: 14 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:1.23 (1.1%) stddev-sans-first:1.01 03:28:14 INFO - PROCESS | 1665 | Values: 110.0 113.0 113.0 111.0 114.0 113.0 112.0 112.0 111.0 113.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:139.50 stddev:23.92 (17.1%) stddev-sans-first:24.82 03:28:14 INFO - PROCESS | 1665 | Values: 143.0 109.0 114.0 176.0 94.0 128.0 135.0 136.0 147.0 107.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:2.15 (1.2%) stddev-sans-first:2.24 03:28:14 INFO - PROCESS | 1665 | Values: 182.0 186.0 184.0 184.0 184.0 185.0 179.0 182.0 181.0 185.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:11.82 (19.7%) stddev-sans-first:11.60 03:28:14 INFO - PROCESS | 1665 | Values: 79.0 59.0 59.0 88.0 61.0 59.0 58.0 59.0 82.0 58.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:76.50 stddev:10.16 (13.3%) stddev-sans-first:10.48 03:28:14 INFO - PROCESS | 1665 | Values: 83.0 69.0 90.0 70.0 69.0 69.0 90.0 67.0 67.0 88.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:1.51 (1.8%) stddev-sans-first:1.48 03:28:14 INFO - PROCESS | 1665 | Values: 87.0 85.0 87.0 85.0 86.0 83.0 87.0 83.0 86.0 85.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 03:28:14 INFO - PROCESS | 1665 | Values: 92.0 92.0 92.0 93.0 93.0 93.0 94.0 93.0 92.0 93.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.25 (1.5%) stddev-sans-first:1.24 03:28:14 INFO - PROCESS | 1665 | Values: 84.0 86.0 87.0 86.0 86.0 85.0 86.0 84.0 86.0 83.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:0.78 03:28:14 INFO - PROCESS | 1665 | Values: 55.0 53.0 52.0 52.0 53.0 53.0 54.0 54.0 53.0 54.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:75.80 Median:73.00 stddev:10.44 (14.3%) stddev-sans-first:11.03 03:28:14 INFO - PROCESS | 1665 | Values: 73.0 80.0 74.0 73.0 71.0 69.0 69.0 70.0 75.0 104.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:1.65 (1.9%) stddev-sans-first:1.67 03:28:14 INFO - PROCESS | 1665 | Values: 85.0 85.0 85.0 88.0 86.0 89.0 86.0 85.0 86.0 89.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:143.00 stddev:13.25 (9.3%) stddev-sans-first:13.90 03:28:14 INFO - PROCESS | 1665 | Values: 140.0 142.0 150.0 148.0 138.0 137.0 140.0 136.0 181.0 144.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.00 stddev:2.00 (1.2%) stddev-sans-first:2.11 03:28:14 INFO - PROCESS | 1665 | Values: 168.0 165.0 163.0 169.0 170.0 168.0 167.0 168.0 168.0 167.0 03:28:14 INFO - PROCESS | 1665 | 03:28:14 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 03:28:14 INFO - PROCESS | 1665 | Values: 68.0 68.0 68.0 70.0 70.0 65.0 67.0 67.0 67.0 67.0 03:28:14 INFO - PROCESS | 1665 | -------- Summary: end -------- 03:28:14 INFO - PROCESS | 1665 | 03:28:15 INFO - TEST-INFO | 1665: exit 0 03:28:15 INFO - TEST-OK | kraken | took 58786ms 03:28:15 INFO - SUITE-END | took 1176s 03:28:15 INFO - Completed test suite (00:19:36) 03:28:15 INFO - javascript benchmark 03:28:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.8203107813533, 3309.3381323735252, 3317.850696718646, 3343.5319055332243, 3380.577427821522, 5490.3411590609085, 5558.555315574749, 5587.078132108198, 5654.547636189101, 5661.490465858077, 5576.33084029916, 5583.357913839899, 5613.550915926727, 5633.6338138021, 5703.800366987156, 5154.793808247666, 5189.558887494568, 5196.610254230938, 5229.058769421503, 5239.318888544484, 5149.485051494839, 5262.05283049051, 5279.128943724281, 5286.154215325549, 5289.418164001957, 5311.282976798141, 5313.867153321159, 5344.7862085516535, 5356.0, 5362.51737343639, 5095.745212739348, 5244.92132618013, 5251.894962100775, 5270.367555893317, 5301.575873930076, 5086.135356989321, 5127.589792816603, 5164.096283150434, 5180.922286165711, 5194.558462530689, 5521.751521181556, 5522.944770552283, 5560.749766260528, 5658.292713410824, 5728.68492232927, 6147.754089836401, 6153.169322141498, 6164.7534098636, 6169.845753856144, 6175.104609831594, 4994.775235114428, 6092.786752463642, 6104.246950856121, 6227.813165605039, 6246.968765156191, 5555.388907220203, 5571.0, 5577.693226872561, 5611.382747897728, 5654.151877218368, 6217.813465595949, 6231.626102433868, 6232.407921247474, 6238.968805156036, 6246.593971391845, 5874.794382196603, 5878.882422351529, 5892.0, 5904.9704751475965, 5921.052631579013, 6094.2077529920825, 6112.625067133501, 6141.087130295746, 6155.84610384735, 6157.96921015392, 6143.96928015357, 6161.260648722093, 6176.938230617726, 6197.938020619827, 6203.16257305267, 6121.755129794848, 6169.56813023093, 6230.844228894223, 6240.095186198067, 6247.406496382927, 4805.711657300573, 4841.685290456109, 4844.370231869834, 4851.902961940741, 4937.555619994146, 4369.541198174146, 4378.78106094694, 4386.846460373871, 4474.127545128734, 4478.0, 5695.572832037614, 5700.059490184073, 5710.885782284331, 5713.114467257582, 5757.827265182052, 6073.331933487313, 6112.625067133501, 6242.375762423721, 6247.718852651642, 6275.341089185661, 5665.943340566541, 5678.602497825113, 5683.26117604717, 5700.40145784695, 5793.507551858055, 5351.812686555952, 5390.056740070472, 5396.487333703292, 5401.405845357008, 5409.107497262908, 6331.113644089739, 6341.746330146835, 6350.523710721714, 6352.523560732963, 6364.64994425311, 6030.276366836008, 6090.969545152246, 6095.817125486243, 6183.907241391293, 6198.907016394667, 6224.097505861715, 6267.780627678009, 6280.7487700491465, 6283.7800676976085, 6315.431611155018, 6081.908771368345, 6125.418085281891, 6130.816075517741, 6140.232470941132, 6144.078388241799, 6232.688365581612, 6238.313785483684, 6251.906221406592, 6253.437190652863, 6258.749650014131, 5653.660780353192, 5848.912266316093, 5871.412858714094, 5978.671173085348, 6004.249468816398, 6061.272647282178, 6070.362611925684, 6083.087536869505, 6105.9694701526205, 6137.815865524041, 5844.094165404369, 5881.882362352643, 5909.852253693692, 5911.379305173067, 5912.024515954819, 5891.528677705859, 5930.970345148246, 5997.520198384032, 6005.309389420273, 6032.939670603238, 5896.941030589639, 5908.556858235564, 5909.940900590939, 5930.495907847881, 5940.227770389822], "value": 5647.363665044704, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.1628007966337, 490.1569300802618, 519.1900635009385, 521.4342438454278, 525.561156434377, 25727.871360643196, 30162.84918575407, 31699.68300316999, 31705.207369815766, 31750.841245793796, 40799.0, 41631.79184104075, 42592.361114583306, 43957.12085758291, 44012.3398149028, 9630.518474076303, 9817.312788104835, 9827.410355378664, 9830.508474576278, 9832.950835245814, 8840.778980525507, 9698.563564639573, 9796.363236389612, 9804.117629413351, 9804.901950980506, 8838.823223535526, 12021.579244726436, 12249.265044097383, 12251.816222756666, 12486.375681215948, 12221.0, 12290.20113692607, 12295.877041229607, 12313.815292770616, 12326.952209062241, 11995.700107497296, 12056.517739290417, 12061.0, 12077.758444831143, 12089.818652720129, 39482.60517394818, 39675.20649587021, 39714.80855574337, 39744.00639984023, 39761.80119099415, 3289.473684210515, 3310.8344582771006, 3332.933341333184, 3370.561826962504, 3468.1156305142026, 29951.700482995107, 30705.539416908763, 30966.72282013725, 32099.6790032099, 32100.03699889007, 3332.566766320387, 3338.532605435241, 3372.64587218341, 3426.811525366104, 3433.2790114076074, 509104.36269461154, 514835.0, 519445.8055419473, 520953.0, 521285.0, 34051.14872128217, 34739.652603473645, 63985.0, 64720.67639661772, 64917.67541162264, 35516.82241588776, 35540.46689299663, 35709.0, 35742.821285893406, 35754.64245357513, 14526.0, 14662.486812961495, 14686.706265874836, 14696.853031469762, 14707.191104489355, 12310.75378492425, 12414.56549020798, 12440.875591243972, 12445.439955201857, 12450.937745311216, 7349.228331025272, 7485.85028299431, 7759.57322347265, 7802.102758182768, 7872.685092596346, 3287.1946373138258, 3356.6139893912514, 3367.831608419618, 3371.190914180579, 3397.5583174187195, 847.6100993543039, 935.3312381647155, 959.7696552827272, 993.9950300248453, 1027.9331843430152, 28888.566671499946, 29808.552871706943, 29906.55140172899, 30686.69313306883, 30694.53958190629, 974.8934958821789, 1032.5921261101823, 1040.7502199472224, 1097.8408130820985, 1118.3122379736403, 11999.100067494974, 15976.680466390608, 16312.265948032367, 16386.344546218257, 17078.0, 711514.0, 967405.0, 987574.0, 989267.0, 990425.0, 49887.00225995533, 50227.24659130116, 57453.42546574564, 58283.0, 58328.416715832296, 1155.5782139519183, 1222.1506053292876, 1240.1814802230665, 1244.1850587864963, 1248.2136254160002, 29139.12582622525, 30409.847950760104, 30612.846935765177, 30743.71743832368, 30883.38233235278, 48634.54096377114, 49280.260796088805, 49300.2604960933, 49331.75334123307, 49381.506184937694, 562261.0, 567442.0, 568664.0, 569433.0, 571881.7029574293, 23524.411889702893, 26587.601185982614, 27328.453430930873, 27405.72594274032, 28175.43649126965, 46129.538704613864, 46169.76915115403, 46512.30231546462, 46631.76684116694, 46816.7659161702, 37446.0, 37515.62484375121, 39129.804350979204, 39859.0, 41263.11158218896, 37359.626403735616, 37921.81039094897, 37994.620053800216, 38845.80577097096, 39316.80341598274, 37715.81142094272, 38003.0, 38493.0, 38506.229875402896, 38568.61431385762, 32345.676543234265, 33499.0, 34204.14489637779, 34297.142571435914, 34415.65584344124, 25171.622425663263, 25250.494990100462, 25385.492290153725, 25461.0, 26069.217923462325], "value": 18961.59814647105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.90185199070237, 369.12885590007596, 379.83856860834146, 384.4195265149625, 402.9939550906735, 15031.473898413544, 15256.694866102685, 17030.914845425785, 20446.795532044674, 20879.197644828117, 16645.66708665826, 19595.804041959575, 19693.21227150912, 20217.49456263594, 20454.284100056502, 5763.711814409273, 5810.506106980912, 5949.375315591866, 5960.463558279754, 5978.641281523101, 5660.886782264352, 5804.941950580483, 5859.150423188635, 5859.619124756899, 5865.149553314767, 4120.711550191488, 4328.870133895973, 5126.538611524962, 5846.2107615472005, 6507.4143327100555, 6263.812085637438, 6553.6395498247575, 6575.736970521173, 6578.572392794453, 6583.177102862166, 5582.330120385539, 5635.661860288355, 5640.661560306354, 5644.0, 5645.717714114319, 20445.591088178153, 22453.877306134793, 23993.40016499584, 25276.034475023414, 25452.872735636203, 2192.4190089626263, 2260.2541161416857, 2274.613315736329, 2308.203669733939, 2394.1261439574605, 9586.041395860428, 15383.538493845203, 15532.844671553366, 15670.0, 15735.291911863993, 1615.4507467461003, 1819.1813683842324, 1901.91441385138, 1931.1020375525447, 1958.3341663834365, 117600.0, 119429.84846288076, 121958.39020804928, 130104.0, 130235.0, 9918.908920018792, 10411.802642696186, 11221.495032723547, 11299.548018079186, 11508.654740357802, 13932.93033534826, 14307.21310327942, 14338.139711617336, 14342.498012569718, 14345.713085738227, 7060.0, 8277.461964972257, 8443.577821109044, 8519.872201916976, 8526.360522960678, 8402.915970840335, 8404.8319033619, 8413.663453461915, 8582.0, 8610.225079742853, 3871.9605109988524, 3891.494105766232, 3918.863529576448, 4384.101259241847, 4455.287154055336, 1582.5489735425579, 1667.8658512211812, 1826.2603645523584, 1829.8627602929832, 1921.8558608104167, 767.9539227646247, 898.389095415124, 906.7325139083986, 925.1904583489446, 955.6464108279981, 20430.387088387073, 20546.69179962302, 21161.624494407813, 21670.241541546286, 21706.891465542572, 908.9091090890857, 916.3265000224962, 920.346553946692, 988.7182153086479, 991.1575161112996, 9245.583948722324, 10549.789004220027, 10843.83734243987, 11294.0, 11360.318380897008, 553974.0, 557309.0, 579967.0, 591313.0, 592340.0, 109701.0, 123958.0, 125702.48595028048, 126896.0, 128248.0, 983.6163896080391, 984.6602921991902, 1025.733309339577, 1047.659510659039, 1050.6060227414719, 18789.96655183978, 19562.0, 19661.705074423608, 19667.70498442496, 19694.310699126036, 55567.0, 57058.0, 57486.0, 57632.135517966424, 58168.12747808871, 80181.5990920065, 80989.19010810052, 81770.0, 81985.59007204926, 83031.0, 7059.258777828254, 7397.334239918433, 7970.97103100818, 7988.132031153418, 8277.875831862648, 9154.908450915673, 11835.763284734085, 12379.257244565355, 12471.189372690746, 13231.40458679381, 10562.260641755003, 10805.783884322112, 11776.470058847544, 11832.99419549348, 11866.228695134789, 10865.076468500267, 11068.501917413896, 11348.262362946381, 11625.6512304631, 11638.0, 10998.230123891251, 11516.30902145874, 11540.307581545134, 11739.589114380955, 11993.34036627959, 7059.682314295972, 7269.709211631687, 7325.157606875065, 8098.271155596025, 8155.755327340189, 10525.89474105249, 11409.0, 11584.247023943753, 11785.764284714429, 11802.055835533309], "value": 9519.917643534836, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.336038660863, 1357.0432844844386, 1515.3938424630146, 1664.267722202231, 1906.475719177226, 7457.25427457254, 7912.604369781517, 8622.439541429803, 8855.158759917813, 8856.822863542742, 8697.608607612658, 8796.868046979285, 8801.98777140629, 8810.163034511712, 8814.735557933256, 2377.9286621401384, 2409.6024156014237, 2411.963820542693, 2412.264259400882, 2413.2880800163907, 2298.6666933294746, 2340.0, 2347.0494449747794, 2348.5537747827943, 2350.7061617297836, 2361.138184562631, 2377.6433534969806, 2391.5336509380677, 2398.412388964706, 2407.6268178432283, 1910.5414700471927, 2298.2186056740707, 2303.7235531736214, 2304.4699719064542, 2317.6523521471745, 2349.189529612281, 2355.4346956730433, 2357.1867705641525, 2357.316378250305, 2358.8348815582917, 8732.987119443782, 8776.254018408443, 8847.823043539158, 8855.070217627184, 8880.8667869982, 5195.090859099642, 5385.407605163429, 5387.4073851876265, 5396.892062158735, 5400.513953744143, 3457.9827100864586, 3613.7470377073614, 3660.816959152058, 3685.0603096210293, 3685.2261025184744, 1065.2915810985685, 1098.7692584557253, 1100.983485247722, 1121.4224674292745, 1124.0501775999348, 11761.529538818437, 11766.11754118436, 11830.52677892892, 11851.822222666668, 11881.049516038696, 4345.326474396474, 4515.932261016087, 4619.353290539327, 4623.514530974267, 4625.444946606362, 9092.954535227282, 9099.953505346837, 9099.954500227457, 9110.453372797654, 9121.635134594542, 4378.6278166356215, 5231.450697676765, 5234.450382709761, 5239.554637855748, 5244.763985620656, 4059.817308221137, 4283.657307415399, 4427.446569178853, 4537.274036154199, 4903.41159060915, 3500.1074725944723, 3798.164403831153, 3809.5238095238096, 3866.2654095721723, 3877.2051729395407, 1161.802493576094, 1185.3065956415594, 1187.8693343732182, 1194.396829601046, 1196.838426812369, 837.5384953256606, 856.8800367948493, 896.6010125494223, 899.4827973915025, 933.3513208320288, 5763.4812866842185, 5840.88318233633, 6030.969845150747, 6040.305364883095, 6087.54343424245, 890.9153630405101, 931.4737173496952, 939.3471537281524, 957.3777044920857, 972.4165500699523, 3867.3425517662067, 3904.6095390461296, 3968.0, 4037.313656678372, 4060.553339132693, 10351.327163734333, 10732.141428685687, 10764.623238186627, 10971.451427428756, 11002.779944401227, 10910.127189824794, 10924.781504369868, 10925.508352124174, 10928.743194532572, 11007.889921100847, 8112.351011919032, 8315.334773218128, 8328.375371847136, 8336.499810011419, 8351.039630442456, 5739.483446489836, 5893.970530147493, 6051.517378242359, 6078.3921607838865, 6120.326764056039, 9534.427934323963, 10225.948870255601, 10244.334118282288, 10254.794904102026, 10268.794624107626, 9383.530823458936, 10454.215933804842, 10458.581656733646, 10465.0, 10470.685879423629, 7029.753958611629, 7189.532680375759, 7201.423886089205, 7215.134183897966, 7217.6030318333, 6655.900161497679, 8106.959465202636, 8238.382121341043, 8342.541160236246, 8526.78683032929, 7574.015378001045, 7577.810554736176, 7589.962050189713, 7608.771736847903, 7610.961945190239, 7276.7089316426745, 7322.121345438582, 7468.10382754073, 7468.738594149178, 7494.250574942462, 6926.0649812276715, 7076.893846592202, 7083.256258093033, 7083.327083927019, 7083.858322833411, 4785.210440277316, 4826.61387089025, 5004.199328107486, 5038.546530812245, 5241.9737901310245, 5114.3862736471865, 5140.581513293768, 5146.716930568855, 5190.574330196499, 5257.658252213747], "value": 4556.979200084376, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8480717237795, 301.73447366317635, 309.71506214282863, 316.07863079124354, 317.20065435103527, 5110.361204849394, 5144.485551444854, 5145.3825540935095, 5196.688198708081, 5250.291210686556, 4194.916101677964, 4820.46974832769, 4844.418669759634, 5051.974740126294, 5208.583313334933, 3809.8857034289017, 3906.8437262509465, 3927.3323534998976, 3932.803359832011, 3943.487346644932, 3280.114369120336, 3280.9343813123724, 3513.806740629277, 3661.9084522886874, 4015.4579131817122, 2953.862762836313, 3703.2038111805955, 3735.570409402926, 3751.8499260029566, 3932.0563064864514, 3711.517502724642, 3915.6897430516133, 3949.328614135604, 3972.9006774830714, 3992.201559688074, 3447.1382154461385, 3457.6888080072663, 3460.4290292101773, 3463.203463203452, 3475.6966137698364, 4941.703497790144, 4995.602110986747, 4998.6750861193905, 5002.374703162105, 5008.223725322581, 4069.8168582413864, 4341.826326946918, 4467.396901418299, 4557.4986751457645, 4567.314902764579, 5465.945340546623, 5476.726163691839, 5477.507024367826, 5483.561315094783, 5502.339719233718, 3462.7056700180515, 3618.8009659468717, 3831.942520862189, 3834.156485573197, 3841.308564458396, 5437.374701909292, 5522.585806064561, 5624.131692836682, 5639.2668953035845, 5757.625754325997, 3186.984065079706, 3265.248992731685, 3837.4052021936645, 3844.7308688392104, 3846.1346197105427, 3939.350007248772, 3941.842326306973, 3942.72400931932, 3943.7042221833476, 3961.3463778476803, 4335.653147748172, 4510.774461276923, 4518.4126063612175, 4523.629895727704, 4546.840860569864, 4200.894977625584, 4774.689645173053, 4868.859585567289, 5265.236540701577, 5380.229181971288, 1063.9521221544894, 1336.8863646589955, 1337.81270622113, 1339.9799003014768, 1343.0, 813.7314686153555, 842.3850589070013, 864.0, 874.7157173918501, 887.9289656827439, 4792.764883703486, 4933.28467372229, 4996.4503904570465, 5006.824761133415, 5011.4236862761245, 5028.069807085701, 5436.401995780461, 5454.509094181463, 5458.945410545924, 5483.341998960151, 4208.284591619432, 4470.413003383817, 4717.056588682209, 4720.362751028636, 4999.500049994971, 2859.242300790292, 2864.7278508541654, 2883.5098033334384, 2886.7979241452895, 2893.2911436698146, 4477.888052798706, 4897.853064408074, 5638.984982703071, 5750.741216645261, 5811.4479124483105, 4906.705597664151, 5307.495787900143, 5680.829575112753, 5747.741351639186, 5787.681677507778, 5248.3701955765555, 5502.614816962854, 5870.26621672291, 5874.0, 5878.206442130343, 4364.381371177268, 4603.010352774169, 5127.846304552172, 5444.3194600674915, 5649.971750141223, 4678.649101317483, 5484.0, 5511.614187006871, 5533.395315358501, 5558.0, 4841.394825646794, 5692.861427714391, 5833.854153646023, 5892.882142357214, 5922.585419020627, 3585.300866331145, 3756.305083559441, 3782.93829862731, 3795.9620403795607, 3796.7152463565894, 5504.981578408007, 5537.197106419466, 5566.332040155045, 5568.63568425722, 5586.217929489956, 4604.539546045368, 5414.242006119068, 5421.132618780976, 5445.727713614383, 5498.367687715804, 5265.97260054874, 5317.989581979412, 5445.537129343892, 5449.746558291536, 5509.311336082989, 4560.703554268962, 5058.924116138187, 5174.301469301596, 5311.946880531145, 5334.839954801362, 5149.330587023663, 5319.361676598678, 5340.519353258225, 5345.679259244303, 5465.890682186255, 4171.749695018188, 5295.205719142159, 5339.359276886798, 5367.3827509836865, 5373.865653358541], "value": 3959.8049645898377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.5540287320425, 719.0544434069199, 760.6691089376122, 811.6266517401993, 814.7107776739253, 15608.0, 16172.514824555254, 16185.0, 16200.918995405036, 16202.108884011375, 14461.63845903853, 14600.926995365035, 14606.050606710556, 14620.926895365508, 14643.487477938274, 675.9662016899135, 696.0151385789102, 824.756696774453, 831.7089018843417, 853.9914600853974, 819.7499762572413, 829.4691397505601, 831.268483734313, 831.6257684042205, 834.8539005674013, 880.7401816464127, 881.2157180109707, 883.4655033704613, 884.9026607073217, 884.9734507964771, 873.720409468967, 874.956252187388, 876.8860048193726, 877.3507604372782, 878.0341624213378, 524.1299442924727, 526.9683818970835, 545.3564793543617, 666.6566718140161, 668.8929771236627, 14595.927020364936, 14624.341904614317, 14637.341319640642, 14639.902007349385, 14644.0, 13509.189448633113, 14037.719245615133, 14053.0, 14057.297135143304, 14402.423903043866, 12218.938905305506, 12501.249925004438, 12583.685407864785, 12599.3070381129, 12935.87064129356, 4487.214737420938, 4503.459584849807, 4584.4957054723955, 4693.78877950493, 4712.269598212282, 69405.65297173482, 91189.54405227998, 118692.40653796762, 119674.80325196724, 122906.38546807299, 10181.134603558781, 10209.846852297072, 10232.130268927076, 10254.743956329596, 10343.896561034293, 21391.930403479764, 21438.0, 21620.243291485036, 21649.783502165094, 21708.240211592518, 7915.485493443023, 8018.438709290411, 8032.196780321921, 8090.069641991128, 8120.472169308976, 4292.506361768436, 4399.6040356368085, 4416.4258646375765, 4435.848613422488, 4527.660425468103, 3612.169201083713, 3764.0401697566945, 3765.811709414573, 3771.245750849841, 3771.9811400943368, 684.2131548719013, 693.0539813155007, 698.9650517474106, 699.0283505926766, 704.0882057735245, 618.783425800966, 666.7699643622942, 669.8928171492636, 672.7140965089817, 703.8345988692653, 8907.198352148338, 9311.0, 9493.382930109521, 9608.855867161998, 9723.270754693427, 628.7967072475303, 645.8901986662279, 654.2476152424749, 671.3582054615105, 683.3098570443888, 4629.398178236807, 4656.767161641905, 4663.207254766698, 4676.321933319649, 4776.880577985578, 94170.52914735382, 122603.0, 123269.0, 126824.0, 130943.0, 117399.0, 120629.0, 120738.0, 121611.39194303972, 124266.0, 100114.4994275024, 100941.0, 103670.0, 106832.46583767187, 107441.0, 9271.211946984313, 9830.213582913493, 9861.457619830979, 9952.950235248778, 9977.60089596408, 48099.75950120227, 55147.72426138004, 61294.774104518554, 62929.0, 64217.678911605144, 78836.60581697055, 82614.17385826065, 83209.75185372346, 84398.57800710957, 90847.0, 12913.289769062792, 13148.539801106916, 13202.735945281232, 13253.271070090852, 13561.0, 14535.27323633793, 14693.55919322422, 14946.701065978403, 14989.400423983354, 15176.620584485476, 13428.261445620585, 13868.375923083284, 13901.791473127709, 13933.23367214813, 14312.355943982753, 13529.661758456117, 13756.793648095487, 13812.0, 13923.791143133063, 14122.0, 13339.866601333862, 13521.86478135206, 13535.483420802168, 13538.661533461742, 13825.308734563432, 10917.290376125526, 11309.71725706831, 11477.208960486036, 11478.253913495597, 11572.24780389272, 10693.572257109628, 11343.262687925258, 11488.195826292414, 11621.070314374661, 11622.883771162518], "value": 7784.761250694256, "unit": "score"}], "name": "dromaeo_css", "value": 7233.236400985844, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 113.0, 111.0, 114.0, 113.0, 112.0, 112.0, 111.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 114.0, 176.0, 94.0, 128.0, 135.0, 136.0, 147.0, 107.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 184.0, 184.0, 184.0, 185.0, 179.0, 182.0, 181.0, 185.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 61.0, 59.0, 58.0, 59.0, 82.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 90.0, 70.0, 69.0, 69.0, 90.0, 67.0, 67.0, 88.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 86.0, 83.0, 87.0, 83.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 93.0, 93.0, 93.0, 94.0, 93.0, 92.0, 93.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 87.0, 86.0, 86.0, 85.0, 86.0, 84.0, 86.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 52.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 74.0, 73.0, 71.0, 69.0, 69.0, 70.0, 75.0, 104.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 88.0, 86.0, 89.0, 86.0, 85.0, 86.0, 89.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 150.0, 148.0, 138.0, 137.0, 140.0, 136.0, 181.0, 144.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 163.0, 169.0, 170.0, 168.0, 167.0, 168.0, 168.0, 167.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 70.0, 70.0, 65.0, 67.0, 67.0, 67.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1426.1999999999998, "alertThreshold": 2.0}]} 03:28:15 INFO - Return code: 0 03:28:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:28:15 INFO - # TBPL SUCCESS # 03:28:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:28:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:28:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:28:15 INFO - 2016-09-22 03:28:15.917 screenresolution[1669:10419] starting screenresolution argv=screenresolution get 03:28:15 INFO - 2016-09-22 03:28:15.921 screenresolution[1669:10419] Display 0: 1600x1200x32@60 03:28:15 INFO - 2016-09-22 03:28:15.927 screenresolution[1670:10422] starting screenresolution argv=screenresolution list 03:28:15 INFO - Available Modes on Display 0 03:28:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:28:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:28:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:28:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:28:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:28:16 INFO - Intel Iris: 03:28:16 INFO - Chipset Model: Intel Iris 03:28:16 INFO - Type: GPU 03:28:16 INFO - Bus: Built-In 03:28:16 INFO - VRAM (Dynamic, Max): 1536 MB 03:28:16 INFO - Vendor: Intel (0x8086) 03:28:16 INFO - Device ID: 0x0a2e 03:28:16 INFO - Revision ID: 0x0009 03:28:16 INFO - Displays: 03:28:16 INFO - Display: 03:28:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:28:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:28:16 INFO - Display Serial Number: 1600x1200 60 03:28:16 INFO - Main Display: Yes 03:28:16 INFO - Mirror: Off 03:28:16 INFO - Online: Yes 03:28:16 INFO - Rotation: Supported 03:28:16 INFO - Return code: 0 03:28:16 INFO - Running post-action listener: _resource_record_post_action 03:28:16 INFO - [mozharness: 2016-09-22 10:28:16.162473Z] Finished run-tests step (success) 03:28:16 INFO - Running post-run listener: _resource_record_post_run 03:28:16 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 33131520; Write bytes: 706093056; Read time: 308; Write time: 1936 03:28:16 INFO - TinderboxPrint: CPU usage
53.5% 03:28:16 INFO - TinderboxPrint: I/O read bytes / time
33,131,520 / 308 03:28:16 INFO - TinderboxPrint: I/O write bytes / time
706,093,056 / 1,936 03:28:16 INFO - TinderboxPrint: CPU idle
2,254.5 (46.5%) 03:28:16 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 03:28:16 INFO - TinderboxPrint: CPU user
1,625.4 (33.5%) 03:28:16 INFO - TinderboxPrint: Swap in / out
433,856,512 / 0 03:28:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 406057472; Write bytes: 406857728; Read time: 30411; Write time: 681 03:28:16 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 29178880; Write bytes: 294440960; Read time: 278; Write time: 1232 03:28:16 INFO - Running post-run listener: _upload_blobber_files 03:28:16 INFO - Blob upload gear active. 03:28:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:28:16 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 03:28:16 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:28:16 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:28:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:28:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:18 INFO - (blobuploader) - INFO - Done attempting. 03:28:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:28:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:19 INFO - (blobuploader) - INFO - Done attempting. 03:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:28:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:23 INFO - (blobuploader) - INFO - Done attempting. 03:28:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:23 INFO - Return code: 0 03:28:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8a1d0c1d7814e354b091b24032018d04a68cba56f912efdb8cb09e2f8cd56d9de1f8e65c58199cead05a33bdb46f9b243b1bb73fd2466f37531c5013e9232f7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/673bda4c86fb324b6c2210ee97d1146ef5f9d1622556b9c06993f37367ba8f68790fac6a0ec09097d14a598f984805c899bf28203d48e30299429d121e5e3684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3f71f96fbdc8ce829b8bcfbe9d2ba60127cf1386ee74783baa0d7072f8e7b040545d4c324dedde9563d2f6615b258290b622d1356a1045f4bbb74265595c265e"} 03:28:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:23 INFO - Contents: 03:28:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8a1d0c1d7814e354b091b24032018d04a68cba56f912efdb8cb09e2f8cd56d9de1f8e65c58199cead05a33bdb46f9b243b1bb73fd2466f37531c5013e9232f7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/673bda4c86fb324b6c2210ee97d1146ef5f9d1622556b9c06993f37367ba8f68790fac6a0ec09097d14a598f984805c899bf28203d48e30299429d121e5e3684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3f71f96fbdc8ce829b8bcfbe9d2ba60127cf1386ee74783baa0d7072f8e7b040545d4c324dedde9563d2f6615b258290b622d1356a1045f4bbb74265595c265e"} 03:28:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:23 INFO - Copying logs to upload dir... 03:28:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.070825 ========= master_lag: 1.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-09-22 03:28:25.730362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 03:28:25.734308) ========= 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.hpONUwXW1P/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.ox2pnjLqad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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/Autoland/sha512/8a1d0c1d7814e354b091b24032018d04a68cba56f912efdb8cb09e2f8cd56d9de1f8e65c58199cead05a33bdb46f9b243b1bb73fd2466f37531c5013e9232f7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/673bda4c86fb324b6c2210ee97d1146ef5f9d1622556b9c06993f37367ba8f68790fac6a0ec09097d14a598f984805c899bf28203d48e30299429d121e5e3684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3f71f96fbdc8ce829b8bcfbe9d2ba60127cf1386ee74783baa0d7072f8e7b040545d4c324dedde9563d2f6615b258290b622d1356a1045f4bbb74265595c265e"} build_url:https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/WQCIdedzT3KlOvzWw9r6bQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8a1d0c1d7814e354b091b24032018d04a68cba56f912efdb8cb09e2f8cd56d9de1f8e65c58199cead05a33bdb46f9b243b1bb73fd2466f37531c5013e9232f7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/673bda4c86fb324b6c2210ee97d1146ef5f9d1622556b9c06993f37367ba8f68790fac6a0ec09097d14a598f984805c899bf28203d48e30299429d121e5e3684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3f71f96fbdc8ce829b8bcfbe9d2ba60127cf1386ee74783baa0d7072f8e7b040545d4c324dedde9563d2f6615b258290b622d1356a1045f4bbb74265595c265e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 03:28:25.769906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:28:25.770244) ========= 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.hpONUwXW1P/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.ox2pnjLqad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005152 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 03:28:25.826610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 03:28:25.826942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 03:28:25.827263) ========= ========= Total master_lag: 2.08 =========