builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0373 starttime: 1473819488.08 results: success (0) buildid: 20160913171707 builduid: f3039f8892644ed48ce22b56e654bde9 revision: a38442afa9317df51b8b47d1251efb851ff54a57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.078396) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.078932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.079325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.130754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.131164) ========= 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.Y86ad24fqD/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.5NfuVHelW0/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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-13 19:18:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-09-13 19:18:08 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098157 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.254779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.255116) ========= 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.Y86ad24fqD/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.5NfuVHelW0/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.025422 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.304483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:08.304953) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a38442afa9317df51b8b47d1251efb851ff54a57 --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 a38442afa9317df51b8b47d1251efb851ff54a57 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y86ad24fqD/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.5NfuVHelW0/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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-13 19:18:08,390 truncating revision to first 12 chars 2016-09-13 19:18:08,391 Setting DEBUG logging. 2016-09-13 19:18:08,391 attempt 1/10 2016-09-13 19:18:08,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a38442afa931?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 19:18:09,017 unpacking tar archive at: autoland-a38442afa931/testing/mozharness/ program finished with exit code 0 elapsedTime=0.909106 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:09.237623) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:09.237986) ========= script_repo_revision: a38442afa9317df51b8b47d1251efb851ff54a57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:09.238452) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:09.238792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 19:18:09.258135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-13 19:18:09.258468) ========= /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.Y86ad24fqD/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.5NfuVHelW0/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18:09 INFO - MultiFileLogger online at 20160913 19:18:09 in /builds/slave/test 19:18:09 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 19:18:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:18:09 INFO - {'append_to_log': False, 19:18:09 INFO - 'base_work_dir': '/builds/slave/test', 19:18:09 INFO - 'blob_upload_branch': 'Autoland', 19:18:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:18:09 INFO - 'branch': 'Autoland', 19:18:09 INFO - 'buildbot_json_path': 'buildprops.json', 19:18:09 INFO - 'config_files': ('talos/mac_config.py',), 19:18:09 INFO - 'default_actions': ('clobber', 19:18:09 INFO - 'read-buildbot-config', 19:18:09 INFO - 'download-and-extract', 19:18:09 INFO - 'populate-webroot', 19:18:09 INFO - 'create-virtualenv', 19:18:09 INFO - 'install', 19:18:09 INFO - 'run-tests'), 19:18:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:18:09 INFO - 'download_minidump_stackwalk': True, 19:18:09 INFO - 'download_symbols': 'ondemand', 19:18:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:18:09 INFO - 'tooltool.py': '/tools/tooltool.py', 19:18:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:18:09 INFO - '/tools/misc-python/virtualenv.py')}, 19:18:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:18:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:18:09 INFO - 'installer_path': 'installer.exe', 19:18:09 INFO - 'log_level': 'info', 19:18:09 INFO - 'log_name': 'talos', 19:18:09 INFO - 'log_to_console': True, 19:18:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:18:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:18:09 INFO - 'opt_config_files': (), 19:18:09 INFO - 'pip_index': False, 19:18:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:18:09 INFO - 'cmd': ('bash', 19:18:09 INFO - '-c', 19:18:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:18:09 INFO - 'enabled': True, 19:18:09 INFO - 'halt_on_failure': False, 19:18:09 INFO - 'name': 'check_screen_resolution'},), 19:18:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:18:09 INFO - 'cmd': ('bash', 19:18:09 INFO - '-c', 19:18:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:18:09 INFO - 'enabled': True, 19:18:09 INFO - 'halt_on_failure': False, 19:18:09 INFO - 'name': 'check_screen_resolution'},), 19:18:09 INFO - 'run_cmd_checks_enabled': True, 19:18:09 INFO - 'sps_profile': False, 19:18:09 INFO - 'sps_profile_interval': 0, 19:18:09 INFO - 'suite': 'dromaeojs', 19:18:09 INFO - 'system_bits': '32', 19:18:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:18:09 INFO - 'title': 't-yosemite-r7-0373', 19:18:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:18:09 INFO - 'use_talos_json': True, 19:18:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:18:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:18:09 INFO - 'work_dir': 'build'} 19:18:09 INFO - [mozharness: 2016-09-14 02:18:09.475086Z] Running clobber step. 19:18:09 INFO - Running pre-action listener: _resource_record_pre_action 19:18:09 INFO - Running main action method: clobber 19:18:09 INFO - rmtree: /builds/slave/test/build 19:18:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:11 INFO - Running post-action listener: _resource_record_post_action 19:18:11 INFO - [mozharness: 2016-09-14 02:18:11.476487Z] Finished clobber step (success) 19:18:11 INFO - [mozharness: 2016-09-14 02:18:11.476661Z] Running read-buildbot-config step. 19:18:11 INFO - Running pre-action listener: _resource_record_pre_action 19:18:11 INFO - Running main action method: read_buildbot_config 19:18:11 INFO - Using buildbot properties: 19:18:11 INFO - { 19:18:11 INFO - "project": "", 19:18:11 INFO - "product": "firefox", 19:18:11 INFO - "script_repo_revision": "production", 19:18:11 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 19:18:11 INFO - "repository": "", 19:18:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 19:18:11 INFO - "buildid": "20160913171707", 19:18:11 INFO - "pgo_build": "False", 19:18:11 INFO - "basedir": "/builds/slave/test", 19:18:11 INFO - "buildnumber": 249, 19:18:11 INFO - "slavename": "t-yosemite-r7-0373", 19:18:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:18:11 INFO - "platform": "yosemite_r7", 19:18:11 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:18:11 INFO - "branch": "autoland", 19:18:11 INFO - "repo_path": "integration/autoland", 19:18:11 INFO - "revision": "a38442afa9317df51b8b47d1251efb851ff54a57", 19:18:11 INFO - "stage_platform": "macosx64", 19:18:11 INFO - "builduid": "f3039f8892644ed48ce22b56e654bde9", 19:18:11 INFO - "slavebuilddir": "test" 19:18:11 INFO - } 19:18:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:18:11 INFO - Running post-action listener: _resource_record_post_action 19:18:11 INFO - [mozharness: 2016-09-14 02:18:11.480008Z] Finished read-buildbot-config step (success) 19:18:11 INFO - [mozharness: 2016-09-14 02:18:11.480142Z] Running download-and-extract step. 19:18:11 INFO - Running pre-action listener: _resource_record_pre_action 19:18:11 INFO - Running main action method: download_and_extract 19:18:11 INFO - mkdir: /builds/slave/test/build/tests 19:18: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')]} 19:18:11 INFO - trying https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:18:11 INFO - Downloading https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 19:18:12 INFO - Downloaded 1199 bytes. 19:18:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:18:12 INFO - Using the following test package requirements: 19:18:12 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:18:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:18:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:18:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'jsshell-mac.zip'], 19:18:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:18:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:18:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:18:12 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:18:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:18:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:18:12 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:18:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:18:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:18:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:18:12 INFO - Fetch https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 19:18:13 INFO - Expected file size: 16424673 19:18:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:18:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:18:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:18:20 INFO - Fetch https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 19:18:20 INFO - Expected file size: 16424673 19:18:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:18:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:18:27 INFO - Fetch https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip into memory 19:18:28 INFO - Expected file size: 14414048 19:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:29 INFO - trying https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 19:18:31 INFO - Downloaded 111444789 bytes. 19:18:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:18:31 INFO - mkdir: /builds/slave/test/properties 19:18:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:18:31 INFO - Writing to file /builds/slave/test/properties/build_url 19:18:31 INFO - Contents: 19:18:31 INFO - build_url:https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:18:32 INFO - Running post-action listener: _resource_record_post_action 19:18:32 INFO - Running post-action listener: set_extra_try_arguments 19:18:32 INFO - [mozharness: 2016-09-14 02:18:32.563497Z] Finished download-and-extract step (success) 19:18:32 INFO - [mozharness: 2016-09-14 02:18:32.563641Z] Running populate-webroot step. 19:18:32 INFO - Running pre-action listener: _resource_record_pre_action 19:18:32 INFO - Running main action method: populate_webroot 19:18:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:18:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:18:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:18:32 INFO - '--tppagecycles', 19:18:32 INFO - '7'], 19:18:32 INFO - 'tests': ['tsvgm']}}, 19:18:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:18:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:18:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:18:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:18:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['damp', 'tps']}, 19:18:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'tests': ['damp', 'tps']}, 19:18:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['dromaeo_dom']}, 19:18:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:18:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['basic_compositor_video']}, 19:18:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:18:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['a11yr', 19:18:32 INFO - 'ts_paint', 19:18:32 INFO - 'tpaint', 19:18:32 INFO - 'sessionrestore', 19:18:32 INFO - 'sessionrestore_no_auto_restore', 19:18:32 INFO - 'tabpaint']}, 19:18:32 INFO - 'other-e10s': {'tests': ['a11yr', 19:18:32 INFO - 'ts_paint', 19:18:32 INFO - 'tpaint', 19:18:32 INFO - 'sessionrestore', 19:18:32 INFO - 'sessionrestore_no_auto_restore', 19:18:32 INFO - 'tabpaint']}, 19:18:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:18:32 INFO - 'ts_paint', 19:18:32 INFO - 'tpaint', 19:18:32 INFO - 'sessionrestore', 19:18:32 INFO - 'sessionrestore_no_auto_restore', 19:18:32 INFO - 'tabpaint']}, 19:18:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:18:32 INFO - 'ts_paint', 19:18:32 INFO - 'tpaint', 19:18:32 INFO - 'sessionrestore', 19:18:32 INFO - 'sessionrestore_no_auto_restore', 19:18:32 INFO - 'tabpaint']}, 19:18:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['a11yr', 19:18:32 INFO - 'ts_paint', 19:18:32 INFO - 'tpaint', 19:18:32 INFO - 'sessionrestore', 19:18:32 INFO - 'sessionrestore_no_auto_restore', 19:18:32 INFO - 'tabpaint']}, 19:18:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['a11yr', 19:18:32 INFO - 'ts_paint', 19:18:32 INFO - 'tpaint', 19:18:32 INFO - 'sessionrestore', 19:18:32 INFO - 'sessionrestore_no_auto_restore', 19:18:32 INFO - 'tabpaint']}, 19:18:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['tsvgx', 19:18:32 INFO - 'tsvgr_opacity', 19:18:32 INFO - 'tart', 19:18:32 INFO - 'tscrollx', 19:18:32 INFO - 'cart']}, 19:18:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:18:32 INFO - 'tsvgr_opacity', 19:18:32 INFO - 'tart', 19:18:32 INFO - 'tscrollx', 19:18:32 INFO - 'cart']}, 19:18:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'talos_options': ['--disable-e10s'], 19:18:32 INFO - 'tests': ['tp5o']}, 19:18:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'tests': ['tp5o']}, 19:18:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'talos_options': ['--disable-e10s', 19:18:32 INFO - '--xperf_path', 19:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:32 INFO - 'tests': ['tp5n']}, 19:18:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:32 INFO - 'talos_options': ['--xperf_path', 19:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:32 INFO - 'tests': ['tp5n']}}, 19:18:32 INFO - 'talos.zip': {'path': '', 19:18:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:18:32 INFO - Running post-action listener: _resource_record_post_action 19:18:32 INFO - [mozharness: 2016-09-14 02:18:32.582500Z] Finished populate-webroot step (success) 19:18:32 INFO - [mozharness: 2016-09-14 02:18:32.582625Z] Running create-virtualenv step. 19:18:32 INFO - Running pre-action listener: _resource_record_pre_action 19:18:32 INFO - Running main action method: create_virtualenv 19:18:32 INFO - Creating virtualenv /builds/slave/test/build/venv 19:18: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 19:18:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:18:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:18:32 INFO - Using real prefix '/tools/python27' 19:18:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 19:18:36 INFO - Installing pip.................done. 19:18:36 INFO - Return code: 0 19:18:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18: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 19:18: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 19:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:36 INFO - 'HOME': '/Users/cltbld', 19:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:36 INFO - 'LOGNAME': 'cltbld', 19:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:36 INFO - 'MOZ_NO_REMOTE': '1', 19:18:36 INFO - 'NO_EM_RESTART': '1', 19:18:36 INFO - 'PAGER': '/bin/cat', 19:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:36 INFO - 'PWD': '/builds/slave/test', 19:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:36 INFO - 'SHELL': '/bin/bash', 19:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:36 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:36 INFO - 'USER': 'cltbld', 19:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:36 INFO - 'XPC_FLAGS': '0x0', 19:18:36 INFO - 'XPC_SERVICE_NAME': '0', 19:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18: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 19:18:36 INFO - Cleaning up... 19:18:36 INFO - Return code: 0 19:18:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18: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 19:18: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 19:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:36 INFO - 'HOME': '/Users/cltbld', 19:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:36 INFO - 'LOGNAME': 'cltbld', 19:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:36 INFO - 'MOZ_NO_REMOTE': '1', 19:18:36 INFO - 'NO_EM_RESTART': '1', 19:18:36 INFO - 'PAGER': '/bin/cat', 19:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:36 INFO - 'PWD': '/builds/slave/test', 19:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:36 INFO - 'SHELL': '/bin/bash', 19:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:36 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:36 INFO - 'USER': 'cltbld', 19:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:36 INFO - 'XPC_FLAGS': '0x0', 19:18:36 INFO - 'XPC_SERVICE_NAME': '0', 19:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:36 INFO - Downloading/unpacking psutil>=3.1.1 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:39 INFO - Installing collected packages: psutil 19:18:39 INFO - Running setup.py install for psutil 19:18:39 INFO - building 'psutil._psutil_osx' extension 19:18:39 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 19:18: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 19:18: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 19:18: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 19:18:40 INFO - building 'psutil._psutil_posix' extension 19:18:40 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 19:18:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:18:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:18:40 INFO - ^ 19:18:40 INFO - 1 warning generated. 19:18:40 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 19:18:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:40 INFO - Successfully installed psutil 19:18:40 INFO - Cleaning up... 19:18:40 INFO - Return code: 0 19:18:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:18:40 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')]} 19:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:40 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')]} 19:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:40 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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18:40 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 19:18:40 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 19:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:40 INFO - 'HOME': '/Users/cltbld', 19:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:40 INFO - 'LOGNAME': 'cltbld', 19:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:40 INFO - 'MOZ_NO_REMOTE': '1', 19:18:40 INFO - 'NO_EM_RESTART': '1', 19:18:40 INFO - 'PAGER': '/bin/cat', 19:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:40 INFO - 'PWD': '/builds/slave/test', 19:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:40 INFO - 'SHELL': '/bin/bash', 19:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:40 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:40 INFO - 'USER': 'cltbld', 19:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:40 INFO - 'XPC_FLAGS': '0x0', 19:18:40 INFO - 'XPC_SERVICE_NAME': '0', 19:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:18:43 INFO - Installing collected packages: mozsystemmonitor 19:18:43 INFO - Running setup.py install for mozsystemmonitor 19:18:43 INFO - Successfully installed mozsystemmonitor 19:18:43 INFO - Cleaning up... 19:18:43 INFO - Return code: 0 19:18:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:43 INFO - 'HOME': '/Users/cltbld', 19:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:43 INFO - 'LOGNAME': 'cltbld', 19:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:43 INFO - 'MOZ_NO_REMOTE': '1', 19:18:43 INFO - 'NO_EM_RESTART': '1', 19:18:43 INFO - 'PAGER': '/bin/cat', 19:18:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:43 INFO - 'PWD': '/builds/slave/test', 19:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:43 INFO - 'SHELL': '/bin/bash', 19:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:43 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:43 INFO - 'USER': 'cltbld', 19:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:43 INFO - 'XPC_FLAGS': '0x0', 19:18:43 INFO - 'XPC_SERVICE_NAME': '0', 19:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:43 INFO - Downloading/unpacking jsonschema==2.5.1 19:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:18:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:46 INFO - Downloading functools32-3.2.3-2.tar.gz 19:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:18:46 INFO - warning: no files found matching '*.txt' 19:18:46 INFO - no previously-included directories found matching 'build' 19:18:46 INFO - no previously-included directories found matching 'dist' 19:18:46 INFO - no previously-included directories found matching '.git*' 19:18:46 INFO - Installing collected packages: jsonschema, functools32 19:18:47 INFO - Running setup.py install for functools32 19:18:47 INFO - warning: no files found matching '*.txt' 19:18:47 INFO - no previously-included directories found matching 'build' 19:18:47 INFO - no previously-included directories found matching 'dist' 19:18:47 INFO - no previously-included directories found matching '.git*' 19:18:47 INFO - Successfully installed jsonschema functools32 19:18:47 INFO - Cleaning up... 19:18:47 INFO - Return code: 0 19:18:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18: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 19:18: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 19:18:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:47 INFO - 'HOME': '/Users/cltbld', 19:18:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:47 INFO - 'LOGNAME': 'cltbld', 19:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:47 INFO - 'MOZ_NO_REMOTE': '1', 19:18:47 INFO - 'NO_EM_RESTART': '1', 19:18:47 INFO - 'PAGER': '/bin/cat', 19:18:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:47 INFO - 'PWD': '/builds/slave/test', 19:18:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:47 INFO - 'SHELL': '/bin/bash', 19:18:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:47 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:47 INFO - 'USER': 'cltbld', 19:18:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:47 INFO - 'XPC_FLAGS': '0x0', 19:18:47 INFO - 'XPC_SERVICE_NAME': '0', 19:18:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:18:47 INFO - Cleaning up... 19:18:47 INFO - Return code: 0 19:18:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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', '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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:18: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 blobuploader==1.2.4 19:18:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:47 INFO - 'HOME': '/Users/cltbld', 19:18:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:47 INFO - 'LOGNAME': 'cltbld', 19:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:47 INFO - 'MOZ_NO_REMOTE': '1', 19:18:47 INFO - 'NO_EM_RESTART': '1', 19:18:47 INFO - 'PAGER': '/bin/cat', 19:18:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:47 INFO - 'PWD': '/builds/slave/test', 19:18:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:47 INFO - 'SHELL': '/bin/bash', 19:18:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:47 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:47 INFO - 'USER': 'cltbld', 19:18:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:47 INFO - 'XPC_FLAGS': '0x0', 19:18:47 INFO - 'XPC_SERVICE_NAME': '0', 19:18:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:50 INFO - Downloading blobuploader-1.2.4.tar.gz 19:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:18:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:18:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:51 INFO - Downloading docopt-0.6.1.tar.gz 19:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:18:51 INFO - Installing collected packages: blobuploader, requests, docopt 19:18:51 INFO - Running setup.py install for blobuploader 19:18:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:51 INFO - Running setup.py install for requests 19:18:52 INFO - Running setup.py install for docopt 19:18:52 INFO - Successfully installed blobuploader requests docopt 19:18:52 INFO - Cleaning up... 19:18:52 INFO - Return code: 0 19:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18: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 19:18: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 19:18:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:52 INFO - 'HOME': '/Users/cltbld', 19:18:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:52 INFO - 'LOGNAME': 'cltbld', 19:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:52 INFO - 'MOZ_NO_REMOTE': '1', 19:18:52 INFO - 'NO_EM_RESTART': '1', 19:18:52 INFO - 'PAGER': '/bin/cat', 19:18:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:52 INFO - 'PWD': '/builds/slave/test', 19:18:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:52 INFO - 'SHELL': '/bin/bash', 19:18:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:52 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:52 INFO - 'USER': 'cltbld', 19:18:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:52 INFO - 'XPC_FLAGS': '0x0', 19:18:52 INFO - 'XPC_SERVICE_NAME': '0', 19:18:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-89bXt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-NgnIIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-eDrwJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-waXy0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ybaP1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Akt542-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-0f9OYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-4nEJuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-vE0H1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:53 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-pc4UHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:54 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-r1lRI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:54 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-p2m7P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:54 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-OMkfag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:54 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-QSb6h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:54 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-B4TRZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:54 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-IxxEHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:54 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-wNLXO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:54 INFO - Running setup.py install for manifestparser 19:18:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Running setup.py install for mozcrash 19:18:55 INFO - Running setup.py install for mozdebug 19:18:55 INFO - Running setup.py install for mozdevice 19:18:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Running setup.py install for mozfile 19:18:55 INFO - Running setup.py install for mozhttpd 19:18:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Running setup.py install for mozinfo 19:18:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Running setup.py install for mozInstall 19:18:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:55 INFO - Running setup.py install for mozleak 19:18:56 INFO - Running setup.py install for mozlog 19:18:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:56 INFO - Running setup.py install for moznetwork 19:18:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:56 INFO - Running setup.py install for mozprocess 19:18:56 INFO - Running setup.py install for mozprofile 19:18:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:56 INFO - Running setup.py install for mozrunner 19:18:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:56 INFO - Running setup.py install for mozscreenshot 19:18:57 INFO - Running setup.py install for moztest 19:18:57 INFO - Running setup.py install for mozversion 19:18:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:57 INFO - Cleaning up... 19:18:57 INFO - Return code: 0 19:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:18: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 19:18: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 19:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:57 INFO - 'HOME': '/Users/cltbld', 19:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:57 INFO - 'LOGNAME': 'cltbld', 19:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:57 INFO - 'MOZ_NO_REMOTE': '1', 19:18:57 INFO - 'NO_EM_RESTART': '1', 19:18:57 INFO - 'PAGER': '/bin/cat', 19:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:57 INFO - 'PWD': '/builds/slave/test', 19:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:57 INFO - 'SHELL': '/bin/bash', 19:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:18:57 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:57 INFO - 'USER': 'cltbld', 19:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:57 INFO - 'XPC_FLAGS': '0x0', 19:18:57 INFO - 'XPC_SERVICE_NAME': '0', 19:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:57 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-9N5vMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18: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)) 19:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:57 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-KRctV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:57 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)) 19:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:57 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-5IrEL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:57 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)) 19:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Q0n32L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18: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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-j6mlgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18: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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-WpIlND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18: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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Ha_FQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18: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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-gp6RtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18: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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-nQFAWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18: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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-BNGf8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-otIr3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18: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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-tLr0Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:58 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)) 19:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:58 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ONEhLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18: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)) 19:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:59 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-8Pa12C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18: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)) 19:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:59 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-mMaqkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18: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)) 19:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:59 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-3EaspE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18: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)) 19:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:59 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-CSFHdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18: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)) 19:18: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)) 19:18: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)) 19:18: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)) 19:18: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)) 19:18: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)) 19:18:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:19:02 INFO - Downloading blessings-1.6.tar.gz 19:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:19:02 INFO - Installing collected packages: blessings 19:19:02 INFO - Running setup.py install for blessings 19:19:02 INFO - Successfully installed blessings 19:19:02 INFO - Cleaning up... 19:19:02 INFO - Return code: 0 19:19:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:02 INFO - Reading from file tmpfile_stdout 19:19:02 INFO - Current package versions: 19:19:02 INFO - blessings == 1.6 19:19:02 INFO - blobuploader == 1.2.4 19:19:02 INFO - docopt == 0.6.1 19:19:02 INFO - functools32 == 3.2.3-2 19:19:02 INFO - jsonschema == 2.5.1 19:19:02 INFO - manifestparser == 1.1 19:19:02 INFO - mozInstall == 1.12 19:19:02 INFO - mozcrash == 0.17 19:19:02 INFO - mozdebug == 0.1 19:19:02 INFO - mozdevice == 0.48 19:19:02 INFO - mozfile == 1.2 19:19:02 INFO - mozhttpd == 0.7 19:19:02 INFO - mozinfo == 0.9 19:19:02 INFO - mozleak == 0.1 19:19:02 INFO - mozlog == 3.3 19:19:02 INFO - moznetwork == 0.27 19:19:02 INFO - mozprocess == 0.23 19:19:02 INFO - mozprofile == 0.28 19:19:02 INFO - mozrunner == 6.12 19:19:02 INFO - mozscreenshot == 0.1 19:19:02 INFO - mozsystemmonitor == 0.3 19:19:02 INFO - moztest == 0.7 19:19:02 INFO - mozversion == 1.4 19:19:02 INFO - psutil == 3.1.1 19:19:02 INFO - requests == 1.2.3 19:19:02 INFO - wsgiref == 0.1.2 19:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:19: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 19:19: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 19:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:02 INFO - 'HOME': '/Users/cltbld', 19:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:02 INFO - 'LOGNAME': 'cltbld', 19:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:02 INFO - 'MOZ_NO_REMOTE': '1', 19:19:02 INFO - 'NO_EM_RESTART': '1', 19:19:02 INFO - 'PAGER': '/bin/cat', 19:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:02 INFO - 'PWD': '/builds/slave/test', 19:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:02 INFO - 'SHELL': '/bin/bash', 19:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:19:02 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:02 INFO - 'USER': 'cltbld', 19:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:02 INFO - 'XPC_FLAGS': '0x0', 19:19:02 INFO - 'XPC_SERVICE_NAME': '0', 19:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19:03 INFO - Cleaning up... 19:19:03 INFO - Return code: 0 19:19:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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 0x100e1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe228d954c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, '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.Y86ad24fqD/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.5NfuVHelW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 19:19: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 19:19: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 19:19:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:19:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:03 INFO - 'HOME': '/Users/cltbld', 19:19:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:03 INFO - 'LOGNAME': 'cltbld', 19:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:03 INFO - 'MOZ_NO_REMOTE': '1', 19:19:03 INFO - 'NO_EM_RESTART': '1', 19:19:03 INFO - 'PAGER': '/bin/cat', 19:19:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:03 INFO - 'PWD': '/builds/slave/test', 19:19:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:03 INFO - 'SHELL': '/bin/bash', 19:19:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:19:03 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:19:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:03 INFO - 'USER': 'cltbld', 19:19:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:03 INFO - 'XPC_FLAGS': '0x0', 19:19:03 INFO - 'XPC_SERVICE_NAME': '0', 19:19:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:19:03 INFO - Cleaning up... 19:19:03 INFO - Return code: 0 19:19:03 INFO - Running post-action listener: _resource_record_post_action 19:19:03 INFO - Running post-action listener: _start_resource_monitoring 19:19:03 INFO - Starting resource monitoring. 19:19:03 INFO - [mozharness: 2016-09-14 02:19:03.467147Z] Finished create-virtualenv step (success) 19:19:03 INFO - [mozharness: 2016-09-14 02:19:03.468186Z] Running install step. 19:19:03 INFO - Running pre-action listener: _resource_record_pre_action 19:19:03 INFO - Running main action method: install 19:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:03 INFO - Reading from file tmpfile_stdout 19:19:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:19:03 INFO - Reading from file tmpfile_stdout 19:19:03 INFO - Output received: 19:19:03 INFO - Usage: mozinstall [options] installer 19:19:03 INFO - Options: 19:19:03 INFO - -h, --help show this help message and exit 19:19:03 INFO - -d DEST, --destination=DEST 19:19:03 INFO - Directory to install application into. [default: 19:19:03 INFO - "/builds/slave/test"] 19:19:03 INFO - --app=APP Application being installed. [default: firefox] 19:19:03 INFO - mkdir: /builds/slave/test/build/application 19:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:19:38 INFO - Reading from file tmpfile_stdout 19:19:38 INFO - Output received: 19:19:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:19:38 INFO - Running post-action listener: _resource_record_post_action 19:19:38 INFO - [mozharness: 2016-09-14 02:19:38.030350Z] Finished install step (success) 19:19:38 INFO - [mozharness: 2016-09-14 02:19:38.030471Z] Running run-tests step. 19:19:38 INFO - Running pre-action listener: _resource_record_pre_action 19:19:38 INFO - Running main action method: run_tests 19:19:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:38 INFO - 2016-09-13 19:19:38.043 screenresolution[1660:7491] starting screenresolution argv=screenresolution get 19:19:38 INFO - 2016-09-13 19:19:38.045 screenresolution[1660:7491] Display 0: 1600x1200x32@60 19:19:38 INFO - 2016-09-13 19:19:38.052 screenresolution[1661:7494] starting screenresolution argv=screenresolution list 19:19:38 INFO - Available Modes on Display 0 19:19:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:38 INFO - Intel Iris: 19:19:38 INFO - Chipset Model: Intel Iris 19:19:38 INFO - Type: GPU 19:19:38 INFO - Bus: Built-In 19:19:38 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:38 INFO - Vendor: Intel (0x8086) 19:19:38 INFO - Device ID: 0x0a2e 19:19:38 INFO - Revision ID: 0x0009 19:19:38 INFO - Displays: 19:19:38 INFO - Display: 19:19:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:38 INFO - Display Serial Number: 1600x1200 60 19:19:38 INFO - Main Display: Yes 19:19:38 INFO - Mirror: Off 19:19:38 INFO - Online: Yes 19:19:38 INFO - Rotation: Supported 19:19:38 INFO - Return code: 0 19:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:38 INFO - Python 2.7.3 19:19:38 INFO - Return code: 0 19:19:38 INFO - grabbing minidump binary from tooltool 19:19: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')]} 19:19: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 0x100c2fd30>, '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 0x100a55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c27b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19: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 19:19: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 19:19: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 19:19:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:38 INFO - Return code: 0 19:19:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:19:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:19:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19: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/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--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 19:19: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/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0373 --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 19:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y86ad24fqD/Render', 19:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:38 INFO - 'HOME': '/Users/cltbld', 19:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:38 INFO - 'LOGNAME': 'cltbld', 19:19:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:38 INFO - 'MOZ_NO_REMOTE': '1', 19:19:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:38 INFO - 'NO_EM_RESTART': '1', 19:19:38 INFO - 'PAGER': '/bin/cat', 19:19:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:38 INFO - 'PWD': '/builds/slave/test', 19:19:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:38 INFO - 'SHELL': '/bin/bash', 19:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NfuVHelW0/Listeners', 19:19:38 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 19:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:38 INFO - 'USER': 'cltbld', 19:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:38 INFO - 'XPC_FLAGS': '0x0', 19:19:38 INFO - 'XPC_SERVICE_NAME': '0', 19:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19: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/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--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 19:19:38 INFO - mozversion application_buildid: 20160913171707 19:19:38 INFO - mozversion application_changeset: a38442afa9317df51b8b47d1251efb851ff54a57 19:19:38 INFO - mozversion application_display_name: Nightly 19:19:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:38 INFO - mozversion application_name: Firefox 19:19:38 INFO - mozversion application_remotingname: firefox 19:19:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:19:38 INFO - mozversion application_vendor: Mozilla 19:19:38 INFO - mozversion application_version: 51.0a1 19:19:38 INFO - mozversion platform_buildid: 20160913171707 19:19:38 INFO - mozversion platform_changeset: a38442afa9317df51b8b47d1251efb851ff54a57 19:19:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:19:38 INFO - mozversion platform_version: 51.0a1 19:19:38 INFO - using testdate: 1473819578 19:19:38 INFO - actual date: 1473819578 19:19:38 INFO - starting webserver on 'localhost:49277' 19:19:38 INFO - SUITE-START | Running 2 tests 19:19:38 INFO - TEST-START | dromaeo_css 19:19:38 INFO - operating with platform_type : mac_ 19:19:38 INFO - Initialising browser for dromaeo_css test... 19:19:38 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpZmeq5L/profile http://localhost:49277/getInfo.html) 19:19:41 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 19:19:41 INFO - PROCESS | 1671 | colorDepth:24 19:19:41 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 19:19:41 INFO - PROCESS | 1671 | __metrics 19:19:41 INFO - PROCESS | 1671 | 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" 19:19:41 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:41 INFO - TEST-INFO | 1671: exit 0 19:19:41 INFO - Browser initialized. 19:19:41 INFO - Running cycle 1/1 for dromaeo_css test... 19:19:41 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpZmeq5L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:53 INFO - PROCESS | 1676 | RSS: Main: 229113856 19:19:53 INFO - PROCESS | 1676 | 19:20:44 INFO - PROCESS | 1676 | 1473819644788 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] 19:22:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 19:22:58 INFO - PROCESS | 1676 | RSS: Main: 395268096 19:22:58 INFO - PROCESS | 1676 | 19:26:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 19:26:02 INFO - PROCESS | 1676 | RSS: Main: 375443456 19:26:02 INFO - PROCESS | 1676 | 19:29:04 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 19:29:05 INFO - PROCESS | 1676 | RSS: Main: 340570112 19:29:05 INFO - PROCESS | 1676 | 19:32:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 19:32:08 INFO - PROCESS | 1676 | RSS: Main: 343154688 19:32:08 INFO - PROCESS | 1676 | 19:35:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 19:35:12 INFO - PROCESS | 1676 | RSS: Main: 327409664 19:35:12 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 19:38:15 INFO - PROCESS | 1676 | RSS: Main: 488431616 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | __start_tp_report 19:38:15 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 19:38:15 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 19:38:15 INFO - PROCESS | 1676 | |i|pagename|runs| 19:38:15 INFO - PROCESS | 1676 | |0;dojo.html;2747;3332.333533293342;3362.7893958175055;3378.172347774794;3403.5745531808516;5567.832965011046;5696.886062278762;5741.511971482424;5750.539956803456;5767.653940763557;5693.03218452863;5748.166515855209;5755.597108202427;5758.107493338539;5773.509251713609;5183.222516622499;5223.138182199932;5228.843134705965;5267.1309233976535;5282.867928301804;5296.09966305729;5300.178472336794;5301.1253143231515;5304.787808487656;5317.787288508455;5261.789528418878;5288.286081379003;5310.575153987672;5313.229581710669;5318.494742999428;5320.9467905321035;5328.706921119337;5334.546563542103;5351.973240133774;5369;4817.927731084036;4934.703917764946;5053.545180933734;5166.586673066184;5285.973570132125;5644.774209031675;5708.77164913403;5720.799772007959;5725.713714314309;5731.942680573225;6158.6612736299485;6216.316205217422;6218.0362043882815;6273.1531243282025;6279.309275979638;6238.033104868752;6309.684515774193;6310.684465776692;6313.337099604521;6348.650824204667;5717.085266357404;5745.569082318759;5809.622374545641;5865.178874957467;5866.178734977107;6232.158658581034;6278.434940855345;6279.183706118175;6281.654509001957;6293.96853015732;6196.566240363221;6206.782762603287;6211.596246243979;6229.127922090911;6237.157983672237;6084.817455476343;6159.353267906895;6176.629402235791;6282.685865706788;6292.716827742763;6155.72299246535;6182.072689096672;6189.288231853305;6266.968665156736;6271.811845644638;6232.220972378453;6264.874702505925;6271.090691849657;6276.121343011982;6294.559380843297;4925.482824303468;4939.456659767423;5009.023240468074;5009.524095210949;5058.949410505921;4437.7781110944325;4445.911081778411;4500.077484115748;4505.977470112629;4507.57178068083;5720.971395143081;5723.141528770634;5727.627704199213;5745.569082318842;5778.27771528559;6275.560710750295;6293.465055470337;6306.873862522724;6312.147860038928;6326.936730632635;5519.558435325164;5610.354809196994;5630.97184514083;5685.545156387479;5700.9429905701245;5431.511163995259;5438.374586922555;5456.7544460498575;5495.752691128909;5527.143292789624;6308.905366419507;6312.747490100528;6316;6319.968400158062;6332.588381755263;6142.7136481981925;6241.96879015602;6283.120363149254;6286.968565157145;6327.873442531031;5300.01949639318;6221.96889015552;6222.408871157233;6241.21984751906;6266.843328916813;6195.783147589813;6235.220597425322;6248.4376406123665;6256.374362563707;6284.465820405134;6214.844628884314;6236.937630623635;6267.62394256346;6284.685765711788;6300.527460440577;5811.041178205549;5999.280086389661;6096.878062438637;6106.126990750407;6122.785702500391;6139.785107521216;6140.62695141751;6148.661823599745;6161.014237721943;6170.722317495633;5998.070299103646;6015.699215039318;6020.157177995172;6034.879302414015;6056.57603967718;5934.703264836828;6033.78881739137;6106.725197366218;6132.080187971662;6134.846628834315;5949.494292984971;5981.401859813984;5992.820215393371;6046.486048685911;6056.9091463628965 19:38:15 INFO - PROCESS | 1676 | |1;ext.html;514.256898781261;521.7417378397694;526.3867594252696;539.0647227061048;546.8796864689767;29672.70327296729;31014.224644383874;32329.83835080821;32365.190870228198;39721.00697482557;42320;42825;42912.927176820594;43016.13967720644;43026;9641.614335426591;9819.950900245525;9827.262955278382;9831.410115393064;9856;8761.342899282547;8926.2412694921;9662.75843103921;9774.413535187912;9781.90218097817;11828.408579570987;12019.7596048079;12034.69913252167;12296.692582685415;12331.938340308287;12026.579069732561;12101.636950891487;12107.515699372014;12108.939455302667;12123.575674851338;8666.956665216634;8863.512506812123;11779.998700110415;11849.822252666218;11892.167548271624;39478.802605987075;39525.40711889324;39560.40659390083;41916.37125443121;42039.789801051105;3205.871765129392;3305.025017619808;3381.2561236527927;3732.253549290153;3845.615438456132;25514.48971020588;30361.24096897573;31156;31192.688073119207;31201.063968080995;3123.125524853022;3273.9017829465156;3310.470324748053;3373.6963673269524;3376.8649254030056;341466.46333841607;359875;364235;364669;364892;57166.142507862416;57247.71376143176;57343.13985290224;57374.139387909214;57508;60464.395356045876;60479.09281360783;60718.69640651857;60724.96375181223;60792;15695.529134125994;15920;15947.282372293275;15957;15963.122028288324;12474.75050498985;12510.87489125097;12526.997840172764;12530.248185108923;12539.059570532065;11178.44107794607;12174.147809653416;13927.955403344587;13948.372323245478;15436.228188590525;6354.078658594478;6492.253390860112;6522.119513865568;6544.836379090466;6561.311062338481;849.9022612399654;892.723255790707;906.8911730592239;975.6195083917278;1011.7217765114652;28438.289042774097;29227.415451690846;29680.554791678143;29744.256393590334;29814.701852981627;981.8821741391079;1056.3872953686844;1067.2550380128546;1119.2724728926264;1142.2575326037975;14632.122072675673;15133.848661513464;15166.620834479005;15509.379624814881;15520.982272304529;656755;660835;662009.6899515472;663354;664010;46080;48970.755146224044;49063;55341;55368.44631553633;1307.6338625184962;1331.261150061725;1347.8517363090052;1348.3123606960326;1351.8918486521252;27500;30020.549691754204;30441.543376848924;30637.846810765805;31280.374392511567;53637.731811340695;54940;55087;57795.42204577901;57952.710236450235;424306;434180;435013;435129;596258.0187099037;24759.87620061888;24783;25026.37434064163;25093;25288.494230114928;38088.809555952044;43925.462608808535;44839.55160448354;45003.549964501246;45331.773341133085;36783.63216367909;36851;37393.626063739015;37574.3091560875;40130.59542915984;37998.62001380062;38286.80856595699;38385.616143839325;38914.416283756334;39785.403218951156;32310.676893231706;37230.6276937238;38076.809615951744;38119.80940095393;38417.27122279448;32030.839845800623;34331.970040898814;34344.14139646529;34596.654033459345;34797.652023479444;22181.885092225417;23792.40518987039;23956;24595.27833051741;25183.622245666695 19:38:15 INFO - PROCESS | 1676 | |2;jquery.html;350.852641890406;364.17150981517045;373.887833649905;377.4376179492556;397.67192066545107;14950.626234344147;15641.452549160782;19657.41358202863;20940.685889711665;21388.037538310775;17554.736678949826;20452.795472045276;21010.264640737576;21255.787442125573;21262.362129136152;5883.0881213411885;6216.036514340284;6225.377462253784;6227.782027629034;6230.096635987802;4248.936265956013;4597.471290801551;6119.479844213247;6879.071325371061;6924.134483189601;6642.667866606675;6915.861682766342;6927.233555443355;6927.930720692779;6940.4794640401915;6827.624480653562;6863.210730765976;6868.7252509899545;6893.20728116263;6904.3095690430555;5719.513841323493;5900.97049514754;5965.4929331006915;5965.55258355625;6029.78895738647;22168.667469987962;22436.66345004826;25441.49117017668;25718.22845314625;25945.61081583778;2305.5504176685554;2380.952380952371;2446.9755302446924;2453.6564880916685;2921.7516511096583;15046.924765376212;15453.613659658486;15745;15828.28772705231;16433.424830130887;1853.7682789651294;1858.1638262781803;1893.9810601893942;1908.570571621388;1909.7039958806408;120421;122720;123827.38086309601;123939.3803030979;125116.37441812824;10556.102731267774;11021.118310535137;11082.279651822606;11088.889111108947;11288.604898828502;12043.819342709867;12255.938720306342;12727.681807954876;12852.678683032998;12854.871451285368;8359;8451.915480845113;8545.31637469001;8701.608427620773;8701.869471957925;8625.342315149874;8633.740987770378;8674.479531228146;8826.55867206637;8840.204381605687;5764.452377024176;6469.8354296227135;6573.375529324707;6694.83262918431;6704.128463299838;1732.2031865341833;1808.782946046483;1809.7737782777153;1813.184067169779;1816.1282584359317;874.711345256064;925.9259259259243;934.3272843552631;949.8907625623003;966.6230170233614;21489.67765483519;21908.45228869291;22009.559808803733;22048.779512204994;22258.332250032527;930.3394589841154;949.5252373813094;954.4893481987103;964.2912459342377;1004.1765752083221;10374.533146008447;11495.42522873853;11698.532058717556;11789.705257368634;11820.23168494045;565127;575252;577378;577968;578319;115329;119516.4024179891;121474;121528.39235803942;123228;997.6408492942535;1017.1201910347496;1032.7624646331385;1036.9014943580348;1037.6679462571904;19171.32900348537;19387.709184362528;19604.803951960297;19661;19663.213471460982;47516;48190.75904620454;51215.487845121075;52020.21969670534;52663;67123.32876671171;73874.63062684867;73886.26113738793;74642;75627;7134.643267836484;7378.819388897965;7435.962820185864;8128.715494957648;8458.492490450593;10819;11169.827168147227;12905.225686458842;13264.867351326364;13450.46198152063;9998.950005249928;11430.942845285721;11496.770064598828;11746.412679365827;11920.52317907274;9682.661106861226;11332.263402878787;11346.149038821955;11370.94314528422;11589.536418543164;9336.299777516577;11486.425678716198;11701.941490292835;11883.16817822744;11897;7883.159427926588;7975.122736499096;8158.755237342889;8308.916910831056;8313.251807337369;9561.952190239004;11265.493052812479;11644.708882277671;11779.818164551461;11794.115441341763 19:38:15 INFO - PROCESS | 1676 | |3;mootools.html;1344.1397505596426;1410.351238430322;1481.6592183797727;1673.732202847544;1904.0860387014234;7777.18339574345;8271.751847444571;8683.826323473535;8941.821163576724;8942.418742781714;8804.427712198703;8888.377813553054;8903.332250081254;8904.554772261377;8907.955460222689;2387.415083304593;2417.8549287042747;2419.9637005444843;2420.3828023853894;2426.708794944609;2364.3261670423844;2397.4605713714363;2409.7590240975937;2414.2395145529104;2414.7585241475886;2060.206820374159;2383.618621020637;2404.3868813452546;2417.6736140620965;2417.987910060447;2348.729896061958;2376.346504711201;2387.1525608409024;2393.4854006388537;2394.652775347565;2025.7872923342984;2360.197532838843;2365.8698771567556;2368.6565448010115;2376.085207195225;8776.429532080458;8941.150590693873;8963.955180224122;8967;8968.46189228642;5210;5406;5410.945890541084;5442.292501974757;5495.175723641486;3654.9817250913575;3679.712100764738;3737.804177428287;3755.380362240227;3768.698504119664;957.6887511558771;963.0754475703333;970.3741086998846;985.2758222706306;987.2694206287296;11574.6527604172;11651.708707282301;11747.823782643267;11748.941255293668;11754.294742315404;4430.468343798765;4435.600795928382;4613.123506533748;4619.284010978304;4633.30500424939;9204;9205.493697846683;9213.30900182489;9214.723558293263;9228.723138305728;5247.081760691864;5254.947450525522;5262.55268302191;5270.657407268515;5275.894482110413;4162.41726158338;4422.823087076546;4569.109023740339;4573.451185857718;4908.410990681141;3227.3383956288903;3729.7202709796875;3863.9806800965816;3871.438641397038;3875.8449662013204;1157.9478923448464;1173.724174818917;1181.291225264834;1188.1801556925693;1189.690680423079;659.399946049093;740.7074205688723;774.1407038187607;901.7204666553389;906.569379544711;5439.347278326626;5827.0770645686825;5905.557083218776;5908.379620139909;5974.462298393166;445.42540123241304;450.2818005281571;453.81620443719686;977.9266555008403;996.4668902137322;3858.093348063203;3987.4018897165656;4011.3180759270995;4024.8993775155855;4080.8367665293054;10088.546015429323;10494.580216791242;10693.465326733787;10759.569617215224;10815.621453249098;10430.895691043144;10684.893151068545;10713.892861071445;10718.41048742311;10723.410212438392;7961.084475285416;8038.919610803934;8168.346532277523;8285;8290.792730181673;5635.774569017193;5899.911501327398;5985.880282394415;5992.61048031894;6007.7596896125415;9843.803123937625;9926.950365248127;10060.39637621745;10145.847812282675;10148.644797432054;9449.669261576088;9839.819221693442;10206.030427109412;10475.266731329039;10475.52860121281;6508.08886755864;6742.393184613408;7366.558006519626;7494.437917156126;7596.278353556403;8240.13478584764;8291.751247462586;8338.041125270429;8346.374021948499;8422.368322375723;7482.663280152297;7499.100107986858;7517.962410187914;7541.321281084729;7628.80927976805;7245.529040612343;7330.633468326669;7411.0736157980255;7474.177840437439;7499.625018748931;6930.8613827724175;6937.965310173417;6989.370956613726;7014.754483593049;7019.929800701928;4784.112241873305;4797.160496913096;4848.248521479177;4848.660593758403;4982.003599280086;4839.685420447659;4960.355153829979;5111.539961403491;5154.433012368711;5180.637355385087 19:38:15 INFO - PROCESS | 1676 | |4;prototype.html;299.4086678809352;300.60620587031;310.90051183621244;315.13495454976095;316.7228674909454;4055.898602534938;4433;5134.64057515974;5164.354455693038;5221.295125158107;4930.901381972359;5012.6992380457195;5023.422306434761;5076.923846142311;5095.4649761774945;3353.9267434420995;3964.5440774311037;3984.661303789167;3986.6212709792667;4007.639312461878;3159.2417819723332;3596.2807438512273;3759.4962015194005;4009.298372784751;4031.8307690769643;3281.671832816723;3466.289410670819;3594.514740510037;3895.6493915547594;3956.3867600521967;3572.8034958077296;3639.5268615080004;3853.5761066282685;3924.2151569686034;3957.3181397905773;2759.6412466379443;2783.137227459494;3212.903612891617;3267.852946617384;3466.272082862602;4567.588916997486;4841.951580484185;4970.577500912426;4974.6568426525;5006.724630145341;4139.137388175303;4188.853390131361;4523.6202958097765;4548.977255113737;4553.317002449659;5352.973235133838;5362.490563396471;5368.449986256536;5377.838664840061;5386.865328366783;3287.375398674244;3679.2641471705497;3813.951163430051;3842.846286148551;3869.438931354966;4628.421447319085;5575.665460072409;5587.161925711176;5598.300212473441;5627.8593035174035;3229.095853161072;3851.67260782831;3879.9612003880166;3884.2037382336553;3885.320068987916;3706.29580379727;3958.6437220650278;3966.781826999543;3988.3020471417385;4000.6199411055904;4272.5086615039045;4468.50846406895;4513.864584062483;4515.277555591089;4578.816847326137;5113;5113.054084994288;5295.311609490742;5325.520703136736;5397;1258.470957786294;1306.8301120854228;1313.8635080655356;1315.467235769515;1337.6321511584392;859.256742917372;862.5428522882883;872.3500991761051;925.7271252028461;937.7139972308512;5029.572486338702;5045.672031317952;5075.289459475676;5085.973845561884;5103.055934652101;4678.345031695565;5209.218617207449;5258.6581872178185;5525.419830917776;5556.555475561945;4196.356295533794;4919.803207871717;4973.428055773632;4986.850394488171;5080.822171223989;2514.8113891458215;2861.1988643179943;2868.842213678226;2873.7642813590355;2876.9930524316323;4344.891377715582;4673.135469938073;5237.240600112962;5586.469285417878;5648.378678345379;4522.321651752198;4782.852115492326;5560.833175004756;5572;5596.916046259309;4710.599599034121;4817.98822247325;5526.336839579196;5555.916661250085;5631.662100273997;4256.829726810893;4976.32819569368;5404.972975135256;5411.540019098264;5427.918581221206;4905.7792399342825;4930.285108659296;5363.854458216744;5378.569714422915;5397.8110766123;5585.888282234251;5607.887842243051;5629.6903670298525;5631.971840140773;5645.1532270159805;3597.334493118781;3810.7904065276675;3846.6343198931895;3855.768653880776;3866.4007078902814;5066.961272939112;5360.3299587551555;5377.784888604412;5393.1370980642905;5407.107512370639;4940.44376021552;5272.9736351318;5282.4717528246865;5290.6032047597355;5305.594017585266;4353.49934757507;4803.303520989507;4869.293952376956;5358.490943360374;5473.31583552056;4294.763787991566;5093.847184584469;5210.609204309616;5211.973940130427;5338.946610533845;5478.287822583039;5484.177373394023;5488.506034456918;5507;5509.694183490034;5143.819966301162;5370.731463426735;5400.729963501888;5407.405185429679;5422.6475279106735 19:38:15 INFO - PROCESS | 1676 | |5;yui.html;718.5868125827648;750.7447467860926;751.8158051277438;799.4523751230406;839.7690635075354;13341;14915.477958271462;16172.676546469093;16272.837271627295;16316.673666526662;11817.940910295458;14377.281135943213;14789.778153327708;14899.627509312246;14963.92518037411;750.633846399553;826.2398593294183;836.8870202522672;851.2636569367514;853.5134973065356;676.2155899156979;698.5075521757149;699.133074987015;844.6621351459435;847.8601030829906;887.5872719185577;905.2486436257923;909.4770506958492;913.0321858829661;918.9448633082003;906.9093090690944;907.0113576201938;907.5190149220923;908.500324821349;909.0455022226702;527.1776029394119;544.7412479072449;547.5865721380372;673.993260067398;674.3020973292668;12547.24716517012;12589.055820813384;14879.553613391616;15051.172185529791;15108.86683498731;13991.860081399158;14423.062500937405;14495;15103.39586416542;15223.923880380638;11933.16467847251;11943.223690460092;12071.275723456622;12230.633081007583;12288.631341059783;3816.8091595420397;3848.672862806665;3852.6339997700175;3882.611738826095;3980.840766369342;115452.10760495525;116793.41603292014;117539.2369114464;118816;119303;11195.160362972809;11228.550857965753;11329.546818127183;11370.09039276856;11610.419479026015;23449.296521104396;23524.294271171893;23547.175848845207;23554.822258886987;24026.639600406008;8204.958975205085;8216.794580135425;8236.176382361835;8298.875516867252;8386.580670966427;4418.668599855024;4544.818207271738;4573.611243044312;4589.885252868638;4740.976295118502;3636.8545258189906;3781.640744129303;3781.6785573226034;3785.205106927521;3785.9432108518395;621.4065567383138;671.8253254153955;675.7769935921134;679.708553747883;685.2222727204659;639.5459223951046;656.701200953565;679.6363945289246;687.226869771507;701.4773993374969;10096.444695541815;10115.645952391631;10402.219833512365;10516.737081572868;10545.57817687284;567.8779062501582;627.2880280881233;630.895902176145;663.1942190238883;698.9860202795916;4505.954940450553;4719.716816990992;4799.640026997919;4804.375431193923;4834.237612702468;156792.21603891908;160346;163344;171640.1417992902;176299;120725.39637301934;141351.58648413589;145016;147785;148066;117455;119628.99999999825;122842;124349.37825310815;128044;9138.954305228432;9191.264698824212;9206.861897071416;9215.677451289173;9227.76930576741;61348.69325653343;65551;65704;66147;66771.66614167092;63512;73312;101535;102072;105503.4724826371;11541.36522491271;12060.105574662193;12168.391580420766;12283.236276802021;12435.93782031084;13351.532696355582;13375.063745537718;13462.326883655582;13495.325233738078;13552.983526235768;12365.381730913597;12472.126951113334;12479.688007799878;12698.36508174606;12717;12294.262344259372;12537.561185358469;12643.431045602785;12658;12897.919304507357;8752.606132723915;11754.29474231549;13176.077674562688;13673.658158546115;13707.109037912503;10645.361278323326;11088.970808010554;11377.317360958368;11430.199886008233;11618.6514404568;9605.807883842424;11488.712782180179;11489.597864074718;11521;11560.42197890119 19:38:15 INFO - PROCESS | 1676 | __end_tp_report 19:38:15 INFO - PROCESS | 1676 | __start_cc_report 19:38:15 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1472 19:38:15 INFO - PROCESS | 1676 | __end_cc_report 19:38:15 INFO - PROCESS | 1676 | __startTimestamp1473820695771__endTimestamp 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | ------- Summary: start ------- 19:38:15 INFO - PROCESS | 1676 | Number of tests: 6 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5762.28 Median:5999.28 stddev:649.87 (10.8%) stddev-sans-first:607.29 19:38:15 INFO - PROCESS | 1676 | Values: 2747.0 3332.3 3362.8 3378.2 3403.6 5567.8 5696.9 5741.5 5750.5 5767.7 5693.0 5748.2 5755.6 5758.1 5773.5 5183.2 5223.1 5228.8 5267.1 5282.9 5296.1 5300.2 5301.1 5304.8 5317.8 5261.8 5288.3 5310.6 5313.2 5318.5 5320.9 5328.7 5334.5 5352.0 5369.0 4817.9 4934.7 5053.5 5166.6 5286.0 5644.8 5708.8 5720.8 5725.7 5731.9 6158.7 6216.3 6218.0 6273.2 6279.3 6238.0 6309.7 6310.7 6313.3 6348.7 5717.1 5745.6 5809.6 5865.2 5866.2 6232.2 6278.4 6279.2 6281.7 6294.0 6196.6 6206.8 6211.6 6229.1 6237.2 6084.8 6159.4 6176.6 6282.7 6292.7 6155.7 6182.1 6189.3 6267.0 6271.8 6232.2 6264.9 6271.1 6276.1 6294.6 4925.5 4939.5 5009.0 5009.5 5058.9 4437.8 4445.9 4500.1 4506.0 4507.6 5721.0 5723.1 5727.6 5745.6 5778.3 6275.6 6293.5 6306.9 6312.1 6326.9 5519.6 5610.4 5631.0 5685.5 5700.9 5431.5 5438.4 5456.8 5495.8 5527.1 6308.9 6312.7 6316.0 6320.0 6332.6 6142.7 6242.0 6283.1 6287.0 6327.9 5300.0 6222.0 6222.4 6241.2 6266.8 6195.8 6235.2 6248.4 6256.4 6284.5 6214.8 6236.9 6267.6 6284.7 6300.5 5811.0 5999.3 6096.9 6106.1 6122.8 6139.8 6140.6 6148.7 6161.0 6170.7 5998.1 6015.7 6020.2 6034.9 6056.6 5934.7 6033.8 6106.7 6132.1 6134.8 5949.5 5981.4 5992.8 6046.5 6056.9 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:63430.75 Median:200837.82 stddev:137014.25 (68.2%) stddev-sans-first:137317.18 19:38:15 INFO - PROCESS | 1676 | Values: 514.3 521.7 526.4 539.1 546.9 29672.7 31014.2 32329.8 32365.2 39721.0 42320.0 42825.0 42912.9 43016.1 43026.0 9641.6 9820.0 9827.3 9831.4 9856.0 8761.3 8926.2 9662.8 9774.4 9781.9 11828.4 12019.8 12034.7 12296.7 12331.9 12026.6 12101.6 12107.5 12108.9 12123.6 8667.0 8863.5 11780.0 11849.8 11892.2 39478.8 39525.4 39560.4 41916.4 42039.8 3205.9 3305.0 3381.3 3732.3 3845.6 25514.5 30361.2 31156.0 31192.7 31201.1 3123.1 3273.9 3310.5 3373.7 3376.9 341466.5 359875.0 364235.0 364669.0 364892.0 57166.1 57247.7 57343.1 57374.1 57508.0 60464.4 60479.1 60718.7 60725.0 60792.0 15695.5 15920.0 15947.3 15957.0 15963.1 12474.8 12510.9 12527.0 12530.2 12539.1 11178.4 12174.1 13928.0 13948.4 15436.2 6354.1 6492.3 6522.1 6544.8 6561.3 849.9 892.7 906.9 975.6 1011.7 28438.3 29227.4 29680.6 29744.3 29814.7 981.9 1056.4 1067.3 1119.3 1142.3 14632.1 15133.8 15166.6 15509.4 15521.0 656755.0 660835.0 662009.7 663354.0 664010.0 46080.0 48970.8 49063.0 55341.0 55368.4 1307.6 1331.3 1347.9 1348.3 1351.9 27500.0 30020.5 30441.5 30637.8 31280.4 53637.7 54940.0 55087.0 57795.4 57952.7 424306.0 434180.0 435013.0 435129.0 596258.0 24759.9 24783.0 25026.4 25093.0 25288.5 38088.8 43925.5 44839.6 45003.5 45331.8 36783.6 36851.0 37393.6 37574.3 40130.6 37998.6 38286.8 38385.6 38914.4 39785.4 32310.7 37230.6 38076.8 38119.8 38417.3 32030.8 34332.0 34344.1 34596.7 34797.7 22181.9 23792.4 23956.0 24595.3 25183.6 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:34295.58 Median:2450.32 stddev:95962.97 (3916.4%) stddev-sans-first:96198.32 19:38:15 INFO - PROCESS | 1676 | Values: 350.9 364.2 373.9 377.4 397.7 14950.6 15641.5 19657.4 20940.7 21388.0 17554.7 20452.8 21010.3 21255.8 21262.4 5883.1 6216.0 6225.4 6227.8 6230.1 4248.9 4597.5 6119.5 6879.1 6924.1 6642.7 6915.9 6927.2 6927.9 6940.5 6827.6 6863.2 6868.7 6893.2 6904.3 5719.5 5901.0 5965.5 5965.6 6029.8 22168.7 22436.7 25441.5 25718.2 25945.6 2305.6 2381.0 2447.0 2453.7 2921.8 15046.9 15453.6 15745.0 15828.3 16433.4 1853.8 1858.2 1894.0 1908.6 1909.7 120421.0 122720.0 123827.4 123939.4 125116.4 10556.1 11021.1 11082.3 11088.9 11288.6 12043.8 12255.9 12727.7 12852.7 12854.9 8359.0 8451.9 8545.3 8701.6 8701.9 8625.3 8633.7 8674.5 8826.6 8840.2 5764.5 6469.8 6573.4 6694.8 6704.1 1732.2 1808.8 1809.8 1813.2 1816.1 874.7 925.9 934.3 949.9 966.6 21489.7 21908.5 22009.6 22048.8 22258.3 930.3 949.5 954.5 964.3 1004.2 10374.5 11495.4 11698.5 11789.7 11820.2 565127.0 575252.0 577378.0 577968.0 578319.0 115329.0 119516.4 121474.0 121528.4 123228.0 997.6 1017.1 1032.8 1036.9 1037.7 19171.3 19387.7 19604.8 19661.0 19663.2 47516.0 48190.8 51215.5 52020.2 52663.0 67123.3 73874.6 73886.3 74642.0 75627.0 7134.6 7378.8 7436.0 8128.7 8458.5 10819.0 11169.8 12905.2 13264.9 13450.5 9999.0 11430.9 11496.8 11746.4 11920.5 9682.7 11332.3 11346.1 11370.9 11589.5 9336.3 11486.4 11701.9 11883.2 11897.0 7883.2 7975.1 8158.8 8308.9 8313.3 9562.0 11265.5 11644.7 11779.8 11794.1 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5663.22 Median:5046.77 stddev:3200.64 (63.4%) stddev-sans-first:3193.16 19:38:15 INFO - PROCESS | 1676 | Values: 1344.1 1410.4 1481.7 1673.7 1904.1 7777.2 8271.8 8683.8 8941.8 8942.4 8804.4 8888.4 8903.3 8904.6 8908.0 2387.4 2417.9 2420.0 2420.4 2426.7 2364.3 2397.5 2409.8 2414.2 2414.8 2060.2 2383.6 2404.4 2417.7 2418.0 2348.7 2376.3 2387.2 2393.5 2394.7 2025.8 2360.2 2365.9 2368.7 2376.1 8776.4 8941.2 8964.0 8967.0 8968.5 5210.0 5406.0 5410.9 5442.3 5495.2 3655.0 3679.7 3737.8 3755.4 3768.7 957.7 963.1 970.4 985.3 987.3 11574.7 11651.7 11747.8 11748.9 11754.3 4430.5 4435.6 4613.1 4619.3 4633.3 9204.0 9205.5 9213.3 9214.7 9228.7 5247.1 5254.9 5262.6 5270.7 5275.9 4162.4 4422.8 4569.1 4573.5 4908.4 3227.3 3729.7 3864.0 3871.4 3875.8 1157.9 1173.7 1181.3 1188.2 1189.7 659.4 740.7 774.1 901.7 906.6 5439.3 5827.1 5905.6 5908.4 5974.5 445.4 450.3 453.8 977.9 996.5 3858.1 3987.4 4011.3 4024.9 4080.8 10088.5 10494.6 10693.5 10759.6 10815.6 10430.9 10684.9 10713.9 10718.4 10723.4 7961.1 8038.9 8168.3 8285.0 8290.8 5635.8 5899.9 5985.9 5992.6 6007.8 9843.8 9927.0 10060.4 10145.8 10148.6 9449.7 9839.8 10206.0 10475.3 10475.5 6508.1 6742.4 7366.6 7494.4 7596.3 8240.1 8291.8 8338.0 8346.4 8422.4 7482.7 7499.1 7518.0 7541.3 7628.8 7245.5 7330.6 7411.1 7474.2 7499.6 6930.9 6938.0 6989.4 7014.8 7019.9 4784.1 4797.2 4848.2 4848.7 4982.0 4839.7 4960.4 5111.5 5154.4 5180.6 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:4337.35 Median:4930.59 stddev:1315.63 (26.7%) stddev-sans-first:1283.93 19:38:15 INFO - PROCESS | 1676 | Values: 299.4 300.6 310.9 315.1 316.7 4055.9 4433.0 5134.6 5164.4 5221.3 4930.9 5012.7 5023.4 5076.9 5095.5 3353.9 3964.5 3984.7 3986.6 4007.6 3159.2 3596.3 3759.5 4009.3 4031.8 3281.7 3466.3 3594.5 3895.6 3956.4 3572.8 3639.5 3853.6 3924.2 3957.3 2759.6 2783.1 3212.9 3267.9 3466.3 4567.6 4842.0 4970.6 4974.7 5006.7 4139.1 4188.9 4523.6 4549.0 4553.3 5353.0 5362.5 5368.4 5377.8 5386.9 3287.4 3679.3 3814.0 3842.8 3869.4 4628.4 5575.7 5587.2 5598.3 5627.9 3229.1 3851.7 3880.0 3884.2 3885.3 3706.3 3958.6 3966.8 3988.3 4000.6 4272.5 4468.5 4513.9 4515.3 4578.8 5113.0 5113.1 5295.3 5325.5 5397.0 1258.5 1306.8 1313.9 1315.5 1337.6 859.3 862.5 872.4 925.7 937.7 5029.6 5045.7 5075.3 5086.0 5103.1 4678.3 5209.2 5258.7 5525.4 5556.6 4196.4 4919.8 4973.4 4986.9 5080.8 2514.8 2861.2 2868.8 2873.8 2877.0 4344.9 4673.1 5237.2 5586.5 5648.4 4522.3 4782.9 5560.8 5572.0 5596.9 4710.6 4818.0 5526.3 5555.9 5631.7 4256.8 4976.3 5405.0 5411.5 5427.9 4905.8 4930.3 5363.9 5378.6 5397.8 5585.9 5607.9 5629.7 5632.0 5645.2 3597.3 3810.8 3846.6 3855.8 3866.4 5067.0 5360.3 5377.8 5393.1 5407.1 4940.4 5273.0 5282.5 5290.6 5305.6 4353.5 4803.3 4869.3 5358.5 5473.3 4294.8 5093.8 5210.6 5212.0 5338.9 5478.3 5484.2 5488.5 5507.0 5509.7 5143.8 5370.7 5400.7 5407.4 5422.6 19:38:15 INFO - PROCESS | 1676 | 19:38:15 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:26185.37 Median:99874.15 stddev:43291.42 (43.3%) stddev-sans-first:43370.64 19:38:15 INFO - PROCESS | 1676 | Values: 718.6 750.7 751.8 799.5 839.8 13341.0 14915.5 16172.7 16272.8 16316.7 11817.9 14377.3 14789.8 14899.6 14963.9 750.6 826.2 836.9 851.3 853.5 676.2 698.5 699.1 844.7 847.9 887.6 905.2 909.5 913.0 918.9 906.9 907.0 907.5 908.5 909.0 527.2 544.7 547.6 674.0 674.3 12547.2 12589.1 14879.6 15051.2 15108.9 13991.9 14423.1 14495.0 15103.4 15223.9 11933.2 11943.2 12071.3 12230.6 12288.6 3816.8 3848.7 3852.6 3882.6 3980.8 115452.1 116793.4 117539.2 118816.0 119303.0 11195.2 11228.6 11329.5 11370.1 11610.4 23449.3 23524.3 23547.2 23554.8 24026.6 8205.0 8216.8 8236.2 8298.9 8386.6 4418.7 4544.8 4573.6 4589.9 4741.0 3636.9 3781.6 3781.7 3785.2 3785.9 621.4 671.8 675.8 679.7 685.2 639.5 656.7 679.6 687.2 701.5 10096.4 10115.6 10402.2 10516.7 10545.6 567.9 627.3 630.9 663.2 699.0 4506.0 4719.7 4799.6 4804.4 4834.2 156792.2 160346.0 163344.0 171640.1 176299.0 120725.4 141351.6 145016.0 147785.0 148066.0 117455.0 119629.0 122842.0 124349.4 128044.0 9139.0 9191.3 9206.9 9215.7 9227.8 61348.7 65551.0 65704.0 66147.0 66771.7 63512.0 73312.0 101535.0 102072.0 105503.5 11541.4 12060.1 12168.4 12283.2 12435.9 13351.5 13375.1 13462.3 13495.3 13553.0 12365.4 12472.1 12479.7 12698.4 12717.0 12294.3 12537.6 12643.4 12658.0 12897.9 8752.6 11754.3 13176.1 13673.7 13707.1 10645.4 11089.0 11377.3 11430.2 11618.7 9605.8 11488.7 11489.6 11521.0 11560.4 19:38:15 INFO - PROCESS | 1676 | -------- Summary: end -------- 19:38:15 INFO - PROCESS | 1676 | 19:38:16 INFO - TEST-INFO | 1676: exit 0 19:38:16 INFO - TEST-OK | dromaeo_css | took 1117900ms 19:38:16 INFO - TEST-START | kraken 19:38:16 INFO - operating with platform_type : mac_ 19:38:16 INFO - Initialising browser for kraken test... 19:38:16 INFO - TEST-INFO | started process 1795 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmprcecwV/profile http://localhost:49277/getInfo.html) 19:38:18 INFO - PROCESS | 1795 | __metrics Screen width/height:1600/1200 19:38:18 INFO - PROCESS | 1795 | colorDepth:24 19:38:18 INFO - PROCESS | 1795 | Browser inner width/height: 1024/689 19:38:18 INFO - PROCESS | 1795 | __metrics 19:38:18 INFO - PROCESS | 1795 | 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" 19:38:18 INFO - PROCESS | 1795 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:38:19 INFO - TEST-INFO | 1795: exit 0 19:38:19 INFO - Browser initialized. 19:38:19 INFO - Running cycle 1/1 for kraken test... 19:38:19 INFO - TEST-INFO | started process 1796 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmprcecwV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:31 INFO - PROCESS | 1796 | RSS: Main: 229507072 19:38:31 INFO - PROCESS | 1796 | 19:38:34 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 19:38:35 INFO - PROCESS | 1796 | RSS: Main: 291016704 19:38:35 INFO - PROCESS | 1796 | 19:38:38 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 19:38:38 INFO - PROCESS | 1796 | RSS: Main: 291409920 19:38:38 INFO - PROCESS | 1796 | 19:38:42 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 19:38:42 INFO - PROCESS | 1796 | RSS: Main: 379535360 19:38:42 INFO - PROCESS | 1796 | 19:38:44 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 19:38:45 INFO - PROCESS | 1796 | RSS: Main: 281665536 19:38:45 INFO - PROCESS | 1796 | 19:38:47 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:38:47 INFO - PROCESS | 1796 | RSS: Main: 286810112 19:38:47 INFO - PROCESS | 1796 | 19:38:50 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 19:38:51 INFO - PROCESS | 1796 | RSS: Main: 325386240 19:38:51 INFO - PROCESS | 1796 | 19:38:54 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 19:38:54 INFO - PROCESS | 1796 | RSS: Main: 324435968 19:38:54 INFO - PROCESS | 1796 | 19:38:57 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 19:38:58 INFO - PROCESS | 1796 | RSS: Main: 321961984 19:38:58 INFO - PROCESS | 1796 | 19:38:59 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:39:00 INFO - PROCESS | 1796 | RSS: Main: 297545728 19:39:00 INFO - PROCESS | 1796 | 19:39:02 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:39:02 INFO - PROCESS | 1796 | RSS: Main: 302370816 19:39:02 INFO - PROCESS | 1796 | 19:39:05 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:39:05 INFO - PROCESS | 1796 | RSS: Main: 303972352 19:39:05 INFO - PROCESS | 1796 | 19:39:08 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:39:09 INFO - PROCESS | 1796 | RSS: Main: 311578624 19:39:09 INFO - PROCESS | 1796 | 19:39:12 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:39:13 INFO - PROCESS | 1796 | RSS: Main: 313622528 19:39:13 INFO - PROCESS | 1796 | 19:39:14 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 19:39:15 INFO - PROCESS | 1796 | RSS: Main: 357224448 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | __start_tp_report 19:39:15 INFO - PROCESS | 1796 | _x_x_mozilla_page_load 19:39:15 INFO - PROCESS | 1796 | _x_x_mozilla_page_load_details 19:39:15 INFO - PROCESS | 1796 | |i|pagename|runs| 19:39:15 INFO - PROCESS | 1796 | |0;ai-astar;106;114;114;113;113;113;113;111;112;113 19:39:15 INFO - PROCESS | 1796 | |1;audio-beat-detection;144;122;108;145;129;101;126;135;175;109 19:39:15 INFO - PROCESS | 1796 | |2;audio-dft;179;184;183;183;186;181;183;181;183;184 19:39:15 INFO - PROCESS | 1796 | |3;audio-fft;81;59;58;89;61;60;59;58;83;58 19:39:15 INFO - PROCESS | 1796 | |4;audio-oscillator;82;70;92;71;68;70;93;68;69;91 19:39:15 INFO - PROCESS | 1796 | |5;imaging-gaussian-blur;89;86;89;88;89;86;89;87;89;87 19:39:15 INFO - PROCESS | 1796 | |6;imaging-darkroom;94;94;100;93;94;94;95;93;94;94 19:39:15 INFO - PROCESS | 1796 | |7;imaging-desaturate;84;86;84;84;83;83;84;84;86;84 19:39:15 INFO - PROCESS | 1796 | |8;json-parse-financial;44;42;71;80;79;56;54;54;54;55 19:39:15 INFO - PROCESS | 1796 | |9;json-stringify-tinderbox;65;72;70;82;74;70;70;70;72;71 19:39:15 INFO - PROCESS | 1796 | |10;stanford-crypto-aes;98;100;80;88;84;86;83;88;88;76 19:39:15 INFO - PROCESS | 1796 | |11;stanford-crypto-ccm;150;148;142;137;135;138;140;139;260;140 19:39:15 INFO - PROCESS | 1796 | |12;stanford-crypto-pbkdf2;169;168;174;169;170;167;169;158;212;228 19:39:15 INFO - PROCESS | 1796 | |13;stanford-crypto-sha256-iterative;68;68;68;67;68;68;65;67;66;66 19:39:15 INFO - PROCESS | 1796 | __end_tp_report 19:39:15 INFO - PROCESS | 1796 | __start_cc_report 19:39:15 INFO - PROCESS | 1796 | _x_x_mozilla_cycle_collect,1977 19:39:15 INFO - PROCESS | 1796 | __end_cc_report 19:39:15 INFO - PROCESS | 1796 | __startTimestamp1473820755063__endTimestamp 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | ------- Summary: start ------- 19:39:15 INFO - PROCESS | 1796 | Number of tests: 14 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.35 (2.1%) stddev-sans-first:0.93 19:39:15 INFO - PROCESS | 1796 | Values: 106.0 114.0 114.0 113.0 113.0 113.0 113.0 111.0 112.0 113.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:132.00 stddev:21.89 (16.6%) stddev-sans-first:22.58 19:39:15 INFO - PROCESS | 1796 | Values: 144.0 122.0 108.0 145.0 129.0 101.0 126.0 135.0 175.0 109.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.95 (1.1%) stddev-sans-first:1.54 19:39:15 INFO - PROCESS | 1796 | Values: 179.0 184.0 183.0 183.0 186.0 181.0 183.0 181.0 183.0 184.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#3] audio-fft Cycles:10 Average:66.60 Median:60.50 stddev:12.43 (20.5%) stddev-sans-first:12.04 19:39:15 INFO - PROCESS | 1796 | Values: 81.0 59.0 58.0 89.0 61.0 60.0 59.0 58.0 83.0 58.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:76.50 stddev:10.85 (14.2%) stddev-sans-first:11.38 19:39:15 INFO - PROCESS | 1796 | Values: 82.0 70.0 92.0 71.0 68.0 70.0 93.0 68.0 69.0 91.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:89.00 stddev:1.29 (1.4%) stddev-sans-first:1.30 19:39:15 INFO - PROCESS | 1796 | Values: 89.0 86.0 89.0 88.0 89.0 86.0 89.0 87.0 89.0 87.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:2.01 (2.1%) stddev-sans-first:2.13 19:39:15 INFO - PROCESS | 1796 | Values: 94.0 94.0 100.0 93.0 94.0 94.0 95.0 93.0 94.0 94.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 19:39:15 INFO - PROCESS | 1796 | Values: 84.0 86.0 84.0 84.0 83.0 83.0 84.0 84.0 86.0 84.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:55.50 stddev:13.33 (24.0%) stddev-sans-first:13.00 19:39:15 INFO - PROCESS | 1796 | Values: 44.0 42.0 71.0 80.0 79.0 56.0 54.0 54.0 54.0 55.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:4.33 (6.0%) stddev-sans-first:3.87 19:39:15 INFO - PROCESS | 1796 | Values: 65.0 72.0 70.0 82.0 74.0 70.0 70.0 70.0 72.0 71.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:7.37 (8.5%) stddev-sans-first:6.68 19:39:15 INFO - PROCESS | 1796 | Values: 98.0 100.0 80.0 88.0 84.0 86.0 83.0 88.0 88.0 76.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:141.00 stddev:37.92 (26.9%) stddev-sans-first:40.21 19:39:15 INFO - PROCESS | 1796 | Values: 150.0 148.0 142.0 137.0 135.0 138.0 140.0 139.0 260.0 140.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:169.50 stddev:22.60 (13.3%) stddev-sans-first:23.72 19:39:15 INFO - PROCESS | 1796 | Values: 169.0 168.0 174.0 169.0 170.0 167.0 169.0 158.0 212.0 228.0 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - PROCESS | 1796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 19:39:15 INFO - PROCESS | 1796 | Values: 68.0 68.0 68.0 67.0 68.0 68.0 65.0 67.0 66.0 66.0 19:39:15 INFO - PROCESS | 1796 | -------- Summary: end -------- 19:39:15 INFO - PROCESS | 1796 | 19:39:15 INFO - TEST-INFO | 1796: exit 0 19:39:15 INFO - TEST-OK | kraken | took 59384ms 19:39:15 INFO - SUITE-END | took 1177s 19:39:16 INFO - Completed test suite (00:19:37) 19:39:16 INFO - javascript benchmark 19:39:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2747.0, 3332.333533293342, 3362.7893958175055, 3378.172347774794, 3403.5745531808516, 5567.832965011046, 5696.886062278762, 5741.511971482424, 5750.539956803456, 5767.653940763557, 5693.03218452863, 5748.166515855209, 5755.597108202427, 5758.107493338539, 5773.509251713609, 5183.222516622499, 5223.138182199932, 5228.843134705965, 5267.1309233976535, 5282.867928301804, 5296.09966305729, 5300.178472336794, 5301.1253143231515, 5304.787808487656, 5317.787288508455, 5261.789528418878, 5288.286081379003, 5310.575153987672, 5313.229581710669, 5318.494742999428, 5320.9467905321035, 5328.706921119337, 5334.546563542103, 5351.973240133774, 5369.0, 4817.927731084036, 4934.703917764946, 5053.545180933734, 5166.586673066184, 5285.973570132125, 5644.774209031675, 5708.77164913403, 5720.799772007959, 5725.713714314309, 5731.942680573225, 6158.6612736299485, 6216.316205217422, 6218.0362043882815, 6273.1531243282025, 6279.309275979638, 6238.033104868752, 6309.684515774193, 6310.684465776692, 6313.337099604521, 6348.650824204667, 5717.085266357404, 5745.569082318759, 5809.622374545641, 5865.178874957467, 5866.178734977107, 6232.158658581034, 6278.434940855345, 6279.183706118175, 6281.654509001957, 6293.96853015732, 6196.566240363221, 6206.782762603287, 6211.596246243979, 6229.127922090911, 6237.157983672237, 6084.817455476343, 6159.353267906895, 6176.629402235791, 6282.685865706788, 6292.716827742763, 6155.72299246535, 6182.072689096672, 6189.288231853305, 6266.968665156736, 6271.811845644638, 6232.220972378453, 6264.874702505925, 6271.090691849657, 6276.121343011982, 6294.559380843297, 4925.482824303468, 4939.456659767423, 5009.023240468074, 5009.524095210949, 5058.949410505921, 4437.7781110944325, 4445.911081778411, 4500.077484115748, 4505.977470112629, 4507.57178068083, 5720.971395143081, 5723.141528770634, 5727.627704199213, 5745.569082318842, 5778.27771528559, 6275.560710750295, 6293.465055470337, 6306.873862522724, 6312.147860038928, 6326.936730632635, 5519.558435325164, 5610.354809196994, 5630.97184514083, 5685.545156387479, 5700.9429905701245, 5431.511163995259, 5438.374586922555, 5456.7544460498575, 5495.752691128909, 5527.143292789624, 6308.905366419507, 6312.747490100528, 6316.0, 6319.968400158062, 6332.588381755263, 6142.7136481981925, 6241.96879015602, 6283.120363149254, 6286.968565157145, 6327.873442531031, 5300.01949639318, 6221.96889015552, 6222.408871157233, 6241.21984751906, 6266.843328916813, 6195.783147589813, 6235.220597425322, 6248.4376406123665, 6256.374362563707, 6284.465820405134, 6214.844628884314, 6236.937630623635, 6267.62394256346, 6284.685765711788, 6300.527460440577, 5811.041178205549, 5999.280086389661, 6096.878062438637, 6106.126990750407, 6122.785702500391, 6139.785107521216, 6140.62695141751, 6148.661823599745, 6161.014237721943, 6170.722317495633, 5998.070299103646, 6015.699215039318, 6020.157177995172, 6034.879302414015, 6056.57603967718, 5934.703264836828, 6033.78881739137, 6106.725197366218, 6132.080187971662, 6134.846628834315, 5949.494292984971, 5981.401859813984, 5992.820215393371, 6046.486048685911, 6056.9091463628965], "value": 5718.7527657015235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.256898781261, 521.7417378397694, 526.3867594252696, 539.0647227061048, 546.8796864689767, 29672.70327296729, 31014.224644383874, 32329.83835080821, 32365.190870228198, 39721.00697482557, 42320.0, 42825.0, 42912.927176820594, 43016.13967720644, 43026.0, 9641.614335426591, 9819.950900245525, 9827.262955278382, 9831.410115393064, 9856.0, 8761.342899282547, 8926.2412694921, 9662.75843103921, 9774.413535187912, 9781.90218097817, 11828.408579570987, 12019.7596048079, 12034.69913252167, 12296.692582685415, 12331.938340308287, 12026.579069732561, 12101.636950891487, 12107.515699372014, 12108.939455302667, 12123.575674851338, 8666.956665216634, 8863.512506812123, 11779.998700110415, 11849.822252666218, 11892.167548271624, 39478.802605987075, 39525.40711889324, 39560.40659390083, 41916.37125443121, 42039.789801051105, 3205.871765129392, 3305.025017619808, 3381.2561236527927, 3732.253549290153, 3845.615438456132, 25514.48971020588, 30361.24096897573, 31156.0, 31192.688073119207, 31201.063968080995, 3123.125524853022, 3273.9017829465156, 3310.470324748053, 3373.6963673269524, 3376.8649254030056, 341466.46333841607, 359875.0, 364235.0, 364669.0, 364892.0, 57166.142507862416, 57247.71376143176, 57343.13985290224, 57374.139387909214, 57508.0, 60464.395356045876, 60479.09281360783, 60718.69640651857, 60724.96375181223, 60792.0, 15695.529134125994, 15920.0, 15947.282372293275, 15957.0, 15963.122028288324, 12474.75050498985, 12510.87489125097, 12526.997840172764, 12530.248185108923, 12539.059570532065, 11178.44107794607, 12174.147809653416, 13927.955403344587, 13948.372323245478, 15436.228188590525, 6354.078658594478, 6492.253390860112, 6522.119513865568, 6544.836379090466, 6561.311062338481, 849.9022612399654, 892.723255790707, 906.8911730592239, 975.6195083917278, 1011.7217765114652, 28438.289042774097, 29227.415451690846, 29680.554791678143, 29744.256393590334, 29814.701852981627, 981.8821741391079, 1056.3872953686844, 1067.2550380128546, 1119.2724728926264, 1142.2575326037975, 14632.122072675673, 15133.848661513464, 15166.620834479005, 15509.379624814881, 15520.982272304529, 656755.0, 660835.0, 662009.6899515472, 663354.0, 664010.0, 46080.0, 48970.755146224044, 49063.0, 55341.0, 55368.44631553633, 1307.6338625184962, 1331.261150061725, 1347.8517363090052, 1348.3123606960326, 1351.8918486521252, 27500.0, 30020.549691754204, 30441.543376848924, 30637.846810765805, 31280.374392511567, 53637.731811340695, 54940.0, 55087.0, 57795.42204577901, 57952.710236450235, 424306.0, 434180.0, 435013.0, 435129.0, 596258.0187099037, 24759.87620061888, 24783.0, 25026.37434064163, 25093.0, 25288.494230114928, 38088.809555952044, 43925.462608808535, 44839.55160448354, 45003.549964501246, 45331.773341133085, 36783.63216367909, 36851.0, 37393.626063739015, 37574.3091560875, 40130.59542915984, 37998.62001380062, 38286.80856595699, 38385.616143839325, 38914.416283756334, 39785.403218951156, 32310.676893231706, 37230.6276937238, 38076.809615951744, 38119.80940095393, 38417.27122279448, 32030.839845800623, 34331.970040898814, 34344.14139646529, 34596.654033459345, 34797.652023479444, 22181.885092225417, 23792.40518987039, 23956.0, 24595.27833051741, 25183.622245666695], "value": 19420.49063695027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.852641890406, 364.17150981517045, 373.887833649905, 377.4376179492556, 397.67192066545107, 14950.626234344147, 15641.452549160782, 19657.41358202863, 20940.685889711665, 21388.037538310775, 17554.736678949826, 20452.795472045276, 21010.264640737576, 21255.787442125573, 21262.362129136152, 5883.0881213411885, 6216.036514340284, 6225.377462253784, 6227.782027629034, 6230.096635987802, 4248.936265956013, 4597.471290801551, 6119.479844213247, 6879.071325371061, 6924.134483189601, 6642.667866606675, 6915.861682766342, 6927.233555443355, 6927.930720692779, 6940.4794640401915, 6827.624480653562, 6863.210730765976, 6868.7252509899545, 6893.20728116263, 6904.3095690430555, 5719.513841323493, 5900.97049514754, 5965.4929331006915, 5965.55258355625, 6029.78895738647, 22168.667469987962, 22436.66345004826, 25441.49117017668, 25718.22845314625, 25945.61081583778, 2305.5504176685554, 2380.952380952371, 2446.9755302446924, 2453.6564880916685, 2921.7516511096583, 15046.924765376212, 15453.613659658486, 15745.0, 15828.28772705231, 16433.424830130887, 1853.7682789651294, 1858.1638262781803, 1893.9810601893942, 1908.570571621388, 1909.7039958806408, 120421.0, 122720.0, 123827.38086309601, 123939.3803030979, 125116.37441812824, 10556.102731267774, 11021.118310535137, 11082.279651822606, 11088.889111108947, 11288.604898828502, 12043.819342709867, 12255.938720306342, 12727.681807954876, 12852.678683032998, 12854.871451285368, 8359.0, 8451.915480845113, 8545.31637469001, 8701.608427620773, 8701.869471957925, 8625.342315149874, 8633.740987770378, 8674.479531228146, 8826.55867206637, 8840.204381605687, 5764.452377024176, 6469.8354296227135, 6573.375529324707, 6694.83262918431, 6704.128463299838, 1732.2031865341833, 1808.782946046483, 1809.7737782777153, 1813.184067169779, 1816.1282584359317, 874.711345256064, 925.9259259259243, 934.3272843552631, 949.8907625623003, 966.6230170233614, 21489.67765483519, 21908.45228869291, 22009.559808803733, 22048.779512204994, 22258.332250032527, 930.3394589841154, 949.5252373813094, 954.4893481987103, 964.2912459342377, 1004.1765752083221, 10374.533146008447, 11495.42522873853, 11698.532058717556, 11789.705257368634, 11820.23168494045, 565127.0, 575252.0, 577378.0, 577968.0, 578319.0, 115329.0, 119516.4024179891, 121474.0, 121528.39235803942, 123228.0, 997.6408492942535, 1017.1201910347496, 1032.7624646331385, 1036.9014943580348, 1037.6679462571904, 19171.32900348537, 19387.709184362528, 19604.803951960297, 19661.0, 19663.213471460982, 47516.0, 48190.75904620454, 51215.487845121075, 52020.21969670534, 52663.0, 67123.32876671171, 73874.63062684867, 73886.26113738793, 74642.0, 75627.0, 7134.643267836484, 7378.819388897965, 7435.962820185864, 8128.715494957648, 8458.492490450593, 10819.0, 11169.827168147227, 12905.225686458842, 13264.867351326364, 13450.46198152063, 9998.950005249928, 11430.942845285721, 11496.770064598828, 11746.412679365827, 11920.52317907274, 9682.661106861226, 11332.263402878787, 11346.149038821955, 11370.94314528422, 11589.536418543164, 9336.299777516577, 11486.425678716198, 11701.941490292835, 11883.16817822744, 11897.0, 7883.159427926588, 7975.122736499096, 8158.755237342889, 8308.916910831056, 8313.251807337369, 9561.952190239004, 11265.493052812479, 11644.708882277671, 11779.818164551461, 11794.115441341763], "value": 9815.955653010811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.1397505596426, 1410.351238430322, 1481.6592183797727, 1673.732202847544, 1904.0860387014234, 7777.18339574345, 8271.751847444571, 8683.826323473535, 8941.821163576724, 8942.418742781714, 8804.427712198703, 8888.377813553054, 8903.332250081254, 8904.554772261377, 8907.955460222689, 2387.415083304593, 2417.8549287042747, 2419.9637005444843, 2420.3828023853894, 2426.708794944609, 2364.3261670423844, 2397.4605713714363, 2409.7590240975937, 2414.2395145529104, 2414.7585241475886, 2060.206820374159, 2383.618621020637, 2404.3868813452546, 2417.6736140620965, 2417.987910060447, 2348.729896061958, 2376.346504711201, 2387.1525608409024, 2393.4854006388537, 2394.652775347565, 2025.7872923342984, 2360.197532838843, 2365.8698771567556, 2368.6565448010115, 2376.085207195225, 8776.429532080458, 8941.150590693873, 8963.955180224122, 8967.0, 8968.46189228642, 5210.0, 5406.0, 5410.945890541084, 5442.292501974757, 5495.175723641486, 3654.9817250913575, 3679.712100764738, 3737.804177428287, 3755.380362240227, 3768.698504119664, 957.6887511558771, 963.0754475703333, 970.3741086998846, 985.2758222706306, 987.2694206287296, 11574.6527604172, 11651.708707282301, 11747.823782643267, 11748.941255293668, 11754.294742315404, 4430.468343798765, 4435.600795928382, 4613.123506533748, 4619.284010978304, 4633.30500424939, 9204.0, 9205.493697846683, 9213.30900182489, 9214.723558293263, 9228.723138305728, 5247.081760691864, 5254.947450525522, 5262.55268302191, 5270.657407268515, 5275.894482110413, 4162.41726158338, 4422.823087076546, 4569.109023740339, 4573.451185857718, 4908.410990681141, 3227.3383956288903, 3729.7202709796875, 3863.9806800965816, 3871.438641397038, 3875.8449662013204, 1157.9478923448464, 1173.724174818917, 1181.291225264834, 1188.1801556925693, 1189.690680423079, 659.399946049093, 740.7074205688723, 774.1407038187607, 901.7204666553389, 906.569379544711, 5439.347278326626, 5827.0770645686825, 5905.557083218776, 5908.379620139909, 5974.462298393166, 445.42540123241304, 450.2818005281571, 453.81620443719686, 977.9266555008403, 996.4668902137322, 3858.093348063203, 3987.4018897165656, 4011.3180759270995, 4024.8993775155855, 4080.8367665293054, 10088.546015429323, 10494.580216791242, 10693.465326733787, 10759.569617215224, 10815.621453249098, 10430.895691043144, 10684.893151068545, 10713.892861071445, 10718.41048742311, 10723.410212438392, 7961.084475285416, 8038.919610803934, 8168.346532277523, 8285.0, 8290.792730181673, 5635.774569017193, 5899.911501327398, 5985.880282394415, 5992.61048031894, 6007.7596896125415, 9843.803123937625, 9926.950365248127, 10060.39637621745, 10145.847812282675, 10148.644797432054, 9449.669261576088, 9839.819221693442, 10206.030427109412, 10475.266731329039, 10475.52860121281, 6508.08886755864, 6742.393184613408, 7366.558006519626, 7494.437917156126, 7596.278353556403, 8240.13478584764, 8291.751247462586, 8338.041125270429, 8346.374021948499, 8422.368322375723, 7482.663280152297, 7499.100107986858, 7517.962410187914, 7541.321281084729, 7628.80927976805, 7245.529040612343, 7330.633468326669, 7411.0736157980255, 7474.177840437439, 7499.625018748931, 6930.8613827724175, 6937.965310173417, 6989.370956613726, 7014.754483593049, 7019.929800701928, 4784.112241873305, 4797.160496913096, 4848.248521479177, 4848.660593758403, 4982.003599280086, 4839.685420447659, 4960.355153829979, 5111.539961403491, 5154.433012368711, 5180.637355385087], "value": 4488.177064880387, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.4086678809352, 300.60620587031, 310.90051183621244, 315.13495454976095, 316.7228674909454, 4055.898602534938, 4433.0, 5134.64057515974, 5164.354455693038, 5221.295125158107, 4930.901381972359, 5012.6992380457195, 5023.422306434761, 5076.923846142311, 5095.4649761774945, 3353.9267434420995, 3964.5440774311037, 3984.661303789167, 3986.6212709792667, 4007.639312461878, 3159.2417819723332, 3596.2807438512273, 3759.4962015194005, 4009.298372784751, 4031.8307690769643, 3281.671832816723, 3466.289410670819, 3594.514740510037, 3895.6493915547594, 3956.3867600521967, 3572.8034958077296, 3639.5268615080004, 3853.5761066282685, 3924.2151569686034, 3957.3181397905773, 2759.6412466379443, 2783.137227459494, 3212.903612891617, 3267.852946617384, 3466.272082862602, 4567.588916997486, 4841.951580484185, 4970.577500912426, 4974.6568426525, 5006.724630145341, 4139.137388175303, 4188.853390131361, 4523.6202958097765, 4548.977255113737, 4553.317002449659, 5352.973235133838, 5362.490563396471, 5368.449986256536, 5377.838664840061, 5386.865328366783, 3287.375398674244, 3679.2641471705497, 3813.951163430051, 3842.846286148551, 3869.438931354966, 4628.421447319085, 5575.665460072409, 5587.161925711176, 5598.300212473441, 5627.8593035174035, 3229.095853161072, 3851.67260782831, 3879.9612003880166, 3884.2037382336553, 3885.320068987916, 3706.29580379727, 3958.6437220650278, 3966.781826999543, 3988.3020471417385, 4000.6199411055904, 4272.5086615039045, 4468.50846406895, 4513.864584062483, 4515.277555591089, 4578.816847326137, 5113.0, 5113.054084994288, 5295.311609490742, 5325.520703136736, 5397.0, 1258.470957786294, 1306.8301120854228, 1313.8635080655356, 1315.467235769515, 1337.6321511584392, 859.256742917372, 862.5428522882883, 872.3500991761051, 925.7271252028461, 937.7139972308512, 5029.572486338702, 5045.672031317952, 5075.289459475676, 5085.973845561884, 5103.055934652101, 4678.345031695565, 5209.218617207449, 5258.6581872178185, 5525.419830917776, 5556.555475561945, 4196.356295533794, 4919.803207871717, 4973.428055773632, 4986.850394488171, 5080.822171223989, 2514.8113891458215, 2861.1988643179943, 2868.842213678226, 2873.7642813590355, 2876.9930524316323, 4344.891377715582, 4673.135469938073, 5237.240600112962, 5586.469285417878, 5648.378678345379, 4522.321651752198, 4782.852115492326, 5560.833175004756, 5572.0, 5596.916046259309, 4710.599599034121, 4817.98822247325, 5526.336839579196, 5555.916661250085, 5631.662100273997, 4256.829726810893, 4976.32819569368, 5404.972975135256, 5411.540019098264, 5427.918581221206, 4905.7792399342825, 4930.285108659296, 5363.854458216744, 5378.569714422915, 5397.8110766123, 5585.888282234251, 5607.887842243051, 5629.6903670298525, 5631.971840140773, 5645.1532270159805, 3597.334493118781, 3810.7904065276675, 3846.6343198931895, 3855.768653880776, 3866.4007078902814, 5066.961272939112, 5360.3299587551555, 5377.784888604412, 5393.1370980642905, 5407.107512370639, 4940.44376021552, 5272.9736351318, 5282.4717528246865, 5290.6032047597355, 5305.594017585266, 4353.49934757507, 4803.303520989507, 4869.293952376956, 5358.490943360374, 5473.31583552056, 4294.763787991566, 5093.847184584469, 5210.609204309616, 5211.973940130427, 5338.946610533845, 5478.287822583039, 5484.177373394023, 5488.506034456918, 5507.0, 5509.694183490034, 5143.819966301162, 5370.731463426735, 5400.729963501888, 5407.405185429679, 5422.6475279106735], "value": 3927.0323045177324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.5868125827648, 750.7447467860926, 751.8158051277438, 799.4523751230406, 839.7690635075354, 13341.0, 14915.477958271462, 16172.676546469093, 16272.837271627295, 16316.673666526662, 11817.940910295458, 14377.281135943213, 14789.778153327708, 14899.627509312246, 14963.92518037411, 750.633846399553, 826.2398593294183, 836.8870202522672, 851.2636569367514, 853.5134973065356, 676.2155899156979, 698.5075521757149, 699.133074987015, 844.6621351459435, 847.8601030829906, 887.5872719185577, 905.2486436257923, 909.4770506958492, 913.0321858829661, 918.9448633082003, 906.9093090690944, 907.0113576201938, 907.5190149220923, 908.500324821349, 909.0455022226702, 527.1776029394119, 544.7412479072449, 547.5865721380372, 673.993260067398, 674.3020973292668, 12547.24716517012, 12589.055820813384, 14879.553613391616, 15051.172185529791, 15108.86683498731, 13991.860081399158, 14423.062500937405, 14495.0, 15103.39586416542, 15223.923880380638, 11933.16467847251, 11943.223690460092, 12071.275723456622, 12230.633081007583, 12288.631341059783, 3816.8091595420397, 3848.672862806665, 3852.6339997700175, 3882.611738826095, 3980.840766369342, 115452.10760495525, 116793.41603292014, 117539.2369114464, 118816.0, 119303.0, 11195.160362972809, 11228.550857965753, 11329.546818127183, 11370.09039276856, 11610.419479026015, 23449.296521104396, 23524.294271171893, 23547.175848845207, 23554.822258886987, 24026.639600406008, 8204.958975205085, 8216.794580135425, 8236.176382361835, 8298.875516867252, 8386.580670966427, 4418.668599855024, 4544.818207271738, 4573.611243044312, 4589.885252868638, 4740.976295118502, 3636.8545258189906, 3781.640744129303, 3781.6785573226034, 3785.205106927521, 3785.9432108518395, 621.4065567383138, 671.8253254153955, 675.7769935921134, 679.708553747883, 685.2222727204659, 639.5459223951046, 656.701200953565, 679.6363945289246, 687.226869771507, 701.4773993374969, 10096.444695541815, 10115.645952391631, 10402.219833512365, 10516.737081572868, 10545.57817687284, 567.8779062501582, 627.2880280881233, 630.895902176145, 663.1942190238883, 698.9860202795916, 4505.954940450553, 4719.716816990992, 4799.640026997919, 4804.375431193923, 4834.237612702468, 156792.21603891908, 160346.0, 163344.0, 171640.1417992902, 176299.0, 120725.39637301934, 141351.58648413589, 145016.0, 147785.0, 148066.0, 117455.0, 119628.99999999825, 122842.0, 124349.37825310815, 128044.0, 9138.954305228432, 9191.264698824212, 9206.861897071416, 9215.677451289173, 9227.76930576741, 61348.69325653343, 65551.0, 65704.0, 66147.0, 66771.66614167092, 63512.0, 73312.0, 101535.0, 102072.0, 105503.4724826371, 11541.36522491271, 12060.105574662193, 12168.391580420766, 12283.236276802021, 12435.93782031084, 13351.532696355582, 13375.063745537718, 13462.326883655582, 13495.325233738078, 13552.983526235768, 12365.381730913597, 12472.126951113334, 12479.688007799878, 12698.36508174606, 12717.0, 12294.262344259372, 12537.561185358469, 12643.431045602785, 12658.0, 12897.919304507357, 8752.606132723915, 11754.29474231549, 13176.077674562688, 13673.658158546115, 13707.109037912503, 10645.361278323326, 11088.970808010554, 11377.317360958368, 11430.199886008233, 11618.6514404568, 9605.807883842424, 11488.712782180179, 11489.597864074718, 11521.0, 11560.42197890119], "value": 7877.754484422488, "unit": "score"}], "name": "dromaeo_css", "value": 7300.397619818016, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 111.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 108.0, 145.0, 129.0, 101.0, 126.0, 135.0, 175.0, 109.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 184.0, 183.0, 183.0, 186.0, 181.0, 183.0, 181.0, 183.0, 184.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 89.0, 61.0, 60.0, 59.0, 58.0, 83.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 92.0, 71.0, 68.0, 70.0, 93.0, 68.0, 69.0, 91.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 88.0, 89.0, 86.0, 89.0, 87.0, 89.0, 87.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 100.0, 93.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 84.0, 83.0, 83.0, 84.0, 84.0, 86.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 42.0, 71.0, 80.0, 79.0, 56.0, 54.0, 54.0, 54.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 70.0, 82.0, 74.0, 70.0, 70.0, 70.0, 72.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 80.0, 88.0, 84.0, 86.0, 83.0, 88.0, 88.0, 76.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 142.0, 137.0, 135.0, 138.0, 140.0, 139.0, 260.0, 140.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 174.0, 169.0, 170.0, 167.0, 169.0, 158.0, 212.0, 228.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 65.0, 67.0, 66.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1450.9, "alertThreshold": 2.0}]} 19:39:16 INFO - Return code: 0 19:39:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:39:16 INFO - # TBPL SUCCESS # 19:39:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:39:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:39:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:39:16 INFO - 2016-09-13 19:39:16.362 screenresolution[1806:9942] starting screenresolution argv=screenresolution get 19:39:16 INFO - 2016-09-13 19:39:16.365 screenresolution[1806:9942] Display 0: 1600x1200x32@60 19:39:16 INFO - 2016-09-13 19:39:16.370 screenresolution[1807:9945] starting screenresolution argv=screenresolution list 19:39:16 INFO - Available Modes on Display 0 19:39:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:39:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:39:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:39:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:39:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:39:16 INFO - Intel Iris: 19:39:16 INFO - Chipset Model: Intel Iris 19:39:16 INFO - Type: GPU 19:39:16 INFO - Bus: Built-In 19:39:16 INFO - VRAM (Dynamic, Max): 1536 MB 19:39:16 INFO - Vendor: Intel (0x8086) 19:39:16 INFO - Device ID: 0x0a2e 19:39:16 INFO - Revision ID: 0x0009 19:39:16 INFO - Displays: 19:39:16 INFO - Display: 19:39:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:39:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:39:16 INFO - Display Serial Number: 1600x1200 60 19:39:16 INFO - Main Display: Yes 19:39:16 INFO - Mirror: Off 19:39:16 INFO - Online: Yes 19:39:16 INFO - Rotation: Supported 19:39:16 INFO - Return code: 0 19:39:16 INFO - Running post-action listener: _resource_record_post_action 19:39:16 INFO - [mozharness: 2016-09-14 02:39:16.610054Z] Finished run-tests step (success) 19:39:16 INFO - Running post-run listener: _resource_record_post_run 19:39:16 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37176320; Write bytes: 707605504; Read time: 239; Write time: 2076 19:39:16 INFO - TinderboxPrint: CPU usage
53.6% 19:39:16 INFO - TinderboxPrint: I/O read bytes / time
37,176,320 / 239 19:39:16 INFO - TinderboxPrint: I/O write bytes / time
707,605,504 / 2,076 19:39:16 INFO - TinderboxPrint: CPU idle
2,250.7 (46.4%) 19:39:16 INFO - TinderboxPrint: CPU system
970.8 (20.0%) 19:39:16 INFO - TinderboxPrint: CPU user
1,628.1 (33.6%) 19:39:16 INFO - TinderboxPrint: Swap in / out
441,806,848 / 0 19:39:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393474560; Write bytes: 388298752; Read time: 29282; Write time: 820 19:39:16 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35271680; Write bytes: 298490880; Read time: 220; Write time: 1205 19:39:17 INFO - Running post-run listener: _upload_blobber_files 19:39:17 INFO - Blob upload gear active. 19:39:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:39:17 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 19:39:17 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'] 19:39:17 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 19:39:17 INFO - (blobuploader) - INFO - Open directory for files ... 19:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:18 INFO - (blobuploader) - INFO - Done attempting. 19:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:19 INFO - (blobuploader) - INFO - Done attempting. 19:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:22 INFO - (blobuploader) - INFO - Done attempting. 19:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 19:39:22 INFO - Return code: 0 19:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:39:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68d1f79a50b4e8e3be0cf4e087d73781622ab7b86072a813101e8054900042aaaaa28f928a102c6e49ae4924ab15bc3ef64bcdba5c092455c6c0fc7064652646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1790f56c88ea3d5b662cfc582c15e1041a5a7d6c4469be6ff0a0af1dac4821ba7ad339781d2d34f9dd36ecc2a9253f1c586f8df5b94c2d3ce3598c219b2dfea9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0c51c910cd63da03a1f4282b2f776587723f92549104f417dd3214e651466d7a63193665c3c203535456a753bb0140698dc6f297321e2ce7c5e53baaf8850a5"} 19:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:39:22 INFO - Contents: 19:39:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68d1f79a50b4e8e3be0cf4e087d73781622ab7b86072a813101e8054900042aaaaa28f928a102c6e49ae4924ab15bc3ef64bcdba5c092455c6c0fc7064652646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1790f56c88ea3d5b662cfc582c15e1041a5a7d6c4469be6ff0a0af1dac4821ba7ad339781d2d34f9dd36ecc2a9253f1c586f8df5b94c2d3ce3598c219b2dfea9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0c51c910cd63da03a1f4282b2f776587723f92549104f417dd3214e651466d7a63193665c3c203535456a753bb0140698dc6f297321e2ce7c5e53baaf8850a5"} 19:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 19:39:22 INFO - Copying logs to upload dir... 19:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 19:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.617267 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-13 19:39:22.916877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 19:39:22.920022) ========= 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.Y86ad24fqD/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.5NfuVHelW0/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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/68d1f79a50b4e8e3be0cf4e087d73781622ab7b86072a813101e8054900042aaaaa28f928a102c6e49ae4924ab15bc3ef64bcdba5c092455c6c0fc7064652646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1790f56c88ea3d5b662cfc582c15e1041a5a7d6c4469be6ff0a0af1dac4821ba7ad339781d2d34f9dd36ecc2a9253f1c586f8df5b94c2d3ce3598c219b2dfea9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0c51c910cd63da03a1f4282b2f776587723f92549104f417dd3214e651466d7a63193665c3c203535456a753bb0140698dc6f297321e2ce7c5e53baaf8850a5"} build_url:https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/EWrX5WJmSaGrNqjfoT0vmw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68d1f79a50b4e8e3be0cf4e087d73781622ab7b86072a813101e8054900042aaaaa28f928a102c6e49ae4924ab15bc3ef64bcdba5c092455c6c0fc7064652646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1790f56c88ea3d5b662cfc582c15e1041a5a7d6c4469be6ff0a0af1dac4821ba7ad339781d2d34f9dd36ecc2a9253f1c586f8df5b94c2d3ce3598c219b2dfea9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0c51c910cd63da03a1f4282b2f776587723f92549104f417dd3214e651466d7a63193665c3c203535456a753bb0140698dc6f297321e2ce7c5e53baaf8850a5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 19:39:22.956850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:39:22.957605) ========= 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.Y86ad24fqD/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.5NfuVHelW0/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.005307 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 19:39:23.010145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 19:39:23.010898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 19:39:23.011675) ========= ========= Total master_lag: 0.19 =========