Back to build
Raw log | Switch to full mode | Login

python -u /b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpRvC7cS.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/5FJQnyh --merge-script /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmp9u4oQpmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpuwDMpU.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpUlDPwB.json in dir /b/s/w/ir/k: allow_subannotations: False cmd: ['python', '-u', '/b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpRvC7cS.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/5FJQnyh', '--merge-script', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmp9u4oQpmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpuwDMpU.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/s/w/ir/tmp/t/tmpUlDPwB.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('cronet_test (iPhone X iOS 11.4) on Mac-10.13.6',) ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.7wwxVJgixk/Render BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 51949 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /Users/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8918897630286301632 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itVVGeLq/luci_context.016991609 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t NO_GCE_CHECK: False PATH: /b/s/w/ir/cache/swarming_client:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/s/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SSH_AUTH_SOCK: /private/tmp/com.apple.launchd.DA0j6SaUIn/Listeners SWARMING_BOT_ID: build212-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 439b5dc2eac0f111 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot VERSIONER_PYTHON_PREFER_32_BIT: no VERSIONER_PYTHON_VERSION: 2.7 VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython XPC_FLAGS: 0x0 XPC_SERVICE_NAME: 0 _: /b/s/w/ir/cipd_bin_packages/vpython __CF_USER_TEXT_ENCODING: 0x1F4:0x0:0x0 Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-03-15 11:30:24,853 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/5FJQnyh' 2019-03-15 11:30:24,853 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/5FJQnyh' already exists! 2019-03-15 11:30:24,853 - root: [WARNING] task_output_dir existing content: [] 2019-03-15 11:30:24,854 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpUlDPwB.json -output-dir /b/s/w/ir/k/recipe_cleanup/5FJQnyh -task-summary-json /b/s/w/ir/tmp/t/tmpuwDMpU.json [D2019-03-15T11:30:24.867903-07:00 38719 0 auth.go:1265] Minting a new token {"key":"luci_ctx/71b9745c6b73e981c034a0cc392bf4f7ac58806ddda7ff63460a30002a7aadbc", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-15T11:30:24.867974-07:00 38719 0 luci_ctx.go:138] POST http://127.0.0.1:51938/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/71b9745c6b73e981c034a0cc392bf4f7ac58806ddda7ff63460a30002a7aadbc", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-15T11:30:24.869340-07:00 38719 0 auth.go:1222] Token expires in 30m19.130688s {"key":"luci_ctx/71b9745c6b73e981c034a0cc392bf4f7ac58806ddda7ff63460a30002a7aadbc", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 439b6072a0ac8e10: exit 0 [I 2019-03-15 11:27:01] About to install Xcode 10b61 in Xcode.app for ios [11:27:02:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer Device wiped. [11:27:10:DEBUG] Setting sigterm handler. [11:27:12:INFO] User defaults from command line: [11:27:12:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/5873CDC5-1685-4881-9E5A-499AA689078C [11:27:12:INFO] [11:27:37:INFO] objc[16303]: Class CRBProtocolObservers is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Bundle/Application/4B520019-E471-4061-9AFF-D7E066CFCC40/cronet_test.app/Frameworks/Cronet.framework/Cronet (0x10b8f5b10) and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Bundle/Application/4B520019-E471-4061-9AFF-D7E066CFCC40/cronet_test.app/cronet_test (0x1032f0658). One of the two will be used. Which one is undefined. [11:27:37:INFO] objc[16303]: Class CRBWeakNSProtocolSentinel is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Bundle/Application/4B520019-E471-4061-9AFF-D7E066CFCC40/cronet_test.app/Frameworks/Cronet.framework/Cronet (0x10b8f5b60) and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Bundle/Application/4B520019-E471-4061-9AFF-D7E066CFCC40/cronet_test.app/cronet_test (0x1032f06a8). One of the two will be used. Which one is undefined. [11:27:37:INFO] 2019-03-15 11:27:37.694 cronet_test[16303:330136] +[CATransaction synchronize] called within transaction [11:27:37:INFO] [==========] Running 166 tests from 14 test suites. [11:27:37:INFO] [----------] Global test environment set-up. [11:27:37:INFO] [----------] 4 tests from BufferTest [11:27:37:INFO] [ RUN ] BufferTest.TestInitWithAlloc [11:27:37:INFO] [ OK ] BufferTest.TestInitWithAlloc (11 ms) [11:27:37:INFO] [ RUN ] BufferTest.TestInitWithHugeAllocFails [11:27:37:INFO] [ OK ] BufferTest.TestInitWithHugeAllocFails (1 ms) [11:27:37:INFO] [ RUN ] BufferTest.TestInitWithDataAndCallback [11:27:37:INFO] [ OK ] BufferTest.TestInitWithDataAndCallback (1 ms) [11:27:37:INFO] [ RUN ] BufferTest.TestCronetBufferAsync [11:27:37:INFO] [ OK ] BufferTest.TestCronetBufferAsync (2 ms) [11:27:37:INFO] [----------] 4 tests from BufferTest (19 ms total) [11:27:37:INFO] [11:27:37:INFO] [----------] 8 tests from EngineTest [11:27:37:INFO] [ RUN ] EngineTest.StartCronetEngine [11:27:38:INFO] [ OK ] EngineTest.StartCronetEngine (75 ms) [11:27:38:INFO] [ RUN ] EngineTest.CronetEngineDefaultUserAgent [11:27:38:INFO] [ OK ] EngineTest.CronetEngineDefaultUserAgent (1 ms) [11:27:38:INFO] [ RUN ] EngineTest.InitDifferentEngines [11:27:38:INFO] [ OK ] EngineTest.InitDifferentEngines (6 ms) [11:27:38:INFO] [ RUN ] EngineTest.StartResults [11:27:38:INFO] [0315/112738.035502:ERROR:engine.cc(135)] Disk cache path /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/tmp/.org.chromium.Chromium.rf0YBN is already used, cache disabled. [11:27:38:INFO] [ OK ] EngineTest.StartResults (169 ms) [11:27:38:INFO] [ RUN ] EngineTest.InvalidPkpParams [11:27:38:INFO] [ OK ] EngineTest.InvalidPkpParams (0 ms) [11:27:38:INFO] [ RUN ] EngineTest.ValidPkpParams [11:27:38:INFO] [ OK ] EngineTest.ValidPkpParams (4 ms) [11:27:38:INFO] [ RUN ] EngineTest.SetMockCertVerifierForTesting [11:27:38:INFO] [ OK ] EngineTest.SetMockCertVerifierForTesting (3 ms) [11:27:38:INFO] [ RUN ] EngineTest.StartNetLogToFile [11:27:38:INFO] [0315/112738.271948:ERROR:cronet_url_request_context.cc(536)] Failed to open NetLog file for writing. [11:27:38:INFO] [ OK ] EngineTest.StartNetLogToFile (60 ms) [11:27:38:INFO] [----------] 8 tests from EngineTest (328 ms total) [11:27:38:INFO] [11:27:38:INFO] [----------] 2 tests from ExecutorsTest [11:27:38:INFO] [ RUN ] ExecutorsTest.TestCustom [11:27:38:INFO] [ OK ] ExecutorsTest.TestCustom (1 ms) [11:27:38:INFO] [ RUN ] ExecutorsTest.TestTestExecutor [11:27:38:INFO] [ OK ] ExecutorsTest.TestTestExecutor (1 ms) [11:27:38:INFO] [----------] 2 tests from ExecutorsTest (4 ms total) [11:27:38:INFO] [11:27:38:INFO] [----------] 57 tests from UrlRequestTest [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadWithDirectExecutor [11:27:38:INFO] [ OK ] UrlRequestTest.UploadWithDirectExecutor (45 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.InitChecks/0 [11:27:38:INFO] [ OK ] UrlRequestTest.InitChecks/0 (5 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.InitChecks/1 [11:27:38:INFO] [ OK ] UrlRequestTest.InitChecks/1 (5 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.SimpleGet/0 [11:27:38:INFO] [ OK ] UrlRequestTest.SimpleGet/0 (8 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.SimpleGet/1 [11:27:38:INFO] [ OK ] UrlRequestTest.SimpleGet/1 (10 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadEmptyBodySync/0 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadEmptyBodySync/0 (11 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadEmptyBodySync/1 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadEmptyBodySync/1 (8 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadSync/0 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadSync/0 (8 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadSync/1 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadSync/1 (9 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.SSLCertificateError/0 [11:27:38:INFO] [0315/112738.462442:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [11:27:38:INFO] [16303:33835:0315/112738.462902:11153129773423:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [11:27:38:INFO] [ OK ] UrlRequestTest.SSLCertificateError/0 (64 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.SSLCertificateError/1 [11:27:38:INFO] [0315/112738.502016:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [11:27:38:INFO] [16303:29487:0315/112738.502193:11153169023149:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [11:27:38:INFO] [ OK ] UrlRequestTest.SSLCertificateError/1 (39 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesSync/0 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesSync/0 (10 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesSync/1 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesSync/1 (10 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesAsync/0 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesAsync/0 (9 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesAsync/1 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesAsync/1 (10 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadChangesDefaultMethod/0 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadChangesDefaultMethod/0 (9 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadChangesDefaultMethod/1 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadChangesDefaultMethod/1 (11 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadWithSetMethod/0 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadWithSetMethod/0 (9 ms) [11:27:38:INFO] [ RUN ] UrlRequestTest.UploadWithSetMethod/1 [11:27:38:INFO] [ OK ] UrlRequestTest.UploadWithSetMethod/1 (64 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadWithBigRead/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadWithBigRead/0 (23 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadWithBigRead/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadWithBigRead/1 (19 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRedirectSync/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRedirectSync/0 (20 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRedirectSync/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRedirectSync/1 (20 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRedirectAsync/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRedirectAsync/0 (16 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRedirectAsync/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRedirectAsync/1 (16 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadWithBadLength/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadWithBadLength/0 (8 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadWithBadLength/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadWithBadLength/1 (9 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadWithBadLengthBufferAligned/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadWithBadLengthBufferAligned/0 (74 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadWithBadLengthBufferAligned/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadWithBadLengthBufferAligned/1 (114 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadReadFailSync/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadReadFailSync/0 (7 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadReadFailSync/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadReadFailSync/1 (7 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadReadFailAsync/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadReadFailAsync/0 (7 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadReadFailAsync/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadReadFailAsync/1 (8 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRewindFailSync/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRewindFailSync/0 (16 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRewindFailSync/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRewindFailSync/1 (11 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRewindFailAsync/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRewindFailAsync/0 (10 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadRewindFailAsync/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadRewindFailAsync/1 (11 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadChunked/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadChunked/0 (9 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadChunked/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadChunked/1 (10 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 (8 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 (9 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadFailsWithoutInitializingStream/0 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadFailsWithoutInitializingStream/0 (6 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.UploadFailsWithoutInitializingStream/1 [11:27:39:INFO] [ OK ] UrlRequestTest.UploadFailsWithoutInitializingStream/1 (7 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.SimpleRequest/0 [11:27:39:INFO] [ OK ] UrlRequestTest.SimpleRequest/0 (7 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.SimpleRequest/1 [11:27:39:INFO] [ OK ] UrlRequestTest.SimpleRequest/1 (7 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.MultiRedirect/0 [11:27:39:INFO] [ OK ] UrlRequestTest.MultiRedirect/0 (13 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.MultiRedirect/1 [11:27:39:INFO] [ OK ] UrlRequestTest.MultiRedirect/1 (15 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.CancelRequest/0 [11:27:39:INFO] [ OK ] UrlRequestTest.CancelRequest/0 (8 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.CancelRequest/1 [11:27:39:INFO] [ OK ] UrlRequestTest.CancelRequest/1 (8 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.FailedRequestHostNotFound/0 [11:27:39:INFO] [ OK ] UrlRequestTest.FailedRequestHostNotFound/0 (6 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.FailedRequestHostNotFound/1 [11:27:39:INFO] [ OK ] UrlRequestTest.FailedRequestHostNotFound/1 (5 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.TestCancel/0 [11:27:39:INFO] [ OK ] UrlRequestTest.TestCancel/0 (70 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.TestCancel/1 [11:27:39:INFO] [ OK ] UrlRequestTest.TestCancel/1 (74 ms) [11:27:39:INFO] [ RUN ] UrlRequestTest.PerfTest/0 [11:27:40:INFO] [16303:771:0315/112740.491931:11155158715134:INFO:url_request_test.cc(993)] Total time 1097.21 ms [11:27:40:INFO] [16303:771:0315/112740.492091:11155158852164:INFO:url_request_test.cc(994)] Single Iteration time 109.721 ms [11:27:40:INFO] [16303:771:0315/112740.492189:11155158948930:INFO:url_request_test.cc(1001)] Average Throughput: 1407.74 mbps [11:27:40:INFO] [ OK ] UrlRequestTest.PerfTest/0 (1137 ms) [11:27:40:INFO] [ RUN ] UrlRequestTest.PerfTest/1 [11:27:42:INFO] [16303:771:0315/112742.710792:11157377502014:INFO:url_request_test.cc(993)] Total time 2195.65 ms [11:27:42:INFO] [16303:771:0315/112742.710924:11157377602150:INFO:url_request_test.cc(994)] Single Iteration time 219.565 ms [11:27:42:INFO] [16303:771:0315/112742.710997:11157377683372:INFO:url_request_test.cc(1001)] Average Throughput: 703.479 mbps [11:27:42:INFO] [ OK ] UrlRequestTest.PerfTest/1 (2217 ms) [11:27:42:INFO] [ RUN ] UrlRequestTest.GetStatus/0 [11:27:42:INFO] [ OK ] UrlRequestTest.GetStatus/0 (8 ms) [11:27:42:INFO] [ RUN ] UrlRequestTest.GetStatus/1 [11:27:42:INFO] [ OK ] UrlRequestTest.GetStatus/1 (10 ms) [11:27:42:INFO] [----------] 57 tests from UrlRequestTest (4456 ms total) [11:27:42:INFO] [11:27:42:INFO] [----------] 5 tests from AcceptLangTest [11:27:42:INFO] [ RUN ] AcceptLangTest.Region [11:27:42:INFO] [ OK ] AcceptLangTest.Region (1 ms) [11:27:42:INFO] [ RUN ] AcceptLangTest.Lang [11:27:42:INFO] [ OK ] AcceptLangTest.Lang (0 ms) [11:27:42:INFO] [ RUN ] AcceptLangTest.Default [11:27:42:INFO] [ OK ] AcceptLangTest.Default (0 ms) [11:27:42:INFO] [ RUN ] AcceptLangTest.Append [11:27:42:INFO] [ OK ] AcceptLangTest.Append (0 ms) [11:27:42:INFO] [ RUN ] AcceptLangTest.NoDefaultAppend [11:27:42:INFO] 2019-03-15 11:27:42.742 cronet_test[16303:330136] en-GB,en-US,en [11:27:42:INFO] [ OK ] AcceptLangTest.NoDefaultAppend (0 ms) [11:27:42:INFO] [----------] 5 tests from AcceptLangTest (7 ms total) [11:27:42:INFO] [11:27:42:INFO] [----------] 21 tests from HttpTest [11:27:42:INFO] [ RUN ] HttpTest.CreateSslKeyLogFile [11:27:42:INFO] 2019-03-15 11:27:42.764 cronet_test[16303:330667] DiskCookieStorage changing policy from 2 to 0, cookie file: file:///Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Library/Cookies/org.chromium.gtest.cronet-test.binarycookies [11:27:42:INFO] [0315/112742.792537:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:42:INFO] [0315/112742.799375:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:42:INFO] [ OK ] HttpTest.CreateSslKeyLogFile (58 ms) [11:27:42:INFO] [ RUN ] HttpTest.NSURLSessionReceivesData [11:27:42:INFO] [0315/112742.971035:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:42:INFO] [ OK ] HttpTest.NSURLSessionReceivesData (170 ms) [11:27:42:INFO] [ RUN ] HttpTest.GetGlobalMetricsDeltas [11:27:43:INFO] [0315/112743.063300:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.GetGlobalMetricsDeltas (90 ms) [11:27:43:INFO] [ RUN ] HttpTest.SdchDisabledByDefault [11:27:43:INFO] [0315/112743.088543:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.SdchDisabledByDefault (25 ms) [11:27:43:INFO] [ RUN ] HttpTest.AcceptEncodingSdchIsAllowed [11:27:43:INFO] [0315/112743.117642:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.AcceptEncodingSdchIsAllowed (28 ms) [11:27:43:INFO] [ RUN ] HttpTest.AcceptEncodingFooBarIsAllowed [11:27:43:INFO] [0315/112743.157151:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.AcceptEncodingFooBarIsAllowed (38 ms) [11:27:43:INFO] [ RUN ] HttpTest.NSURLSessionAcceptLanguage [11:27:43:INFO] [0315/112743.183393:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.NSURLSessionAcceptLanguage (25 ms) [11:27:43:INFO] [ RUN ] HttpTest.SetUserAgentIsExact [11:27:43:INFO] [0315/112743.202043:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.SetUserAgentIsExact (16 ms) [11:27:43:INFO] [ RUN ] HttpTest.SetCookie [11:27:43:INFO] [0315/112743.230288:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.SetCookie (27 ms) [11:27:43:INFO] [ RUN ] HttpTest.SetSystemCookie [11:27:43:INFO] [0315/112743.252063:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.SetSystemCookie (21 ms) [11:27:43:INFO] [ RUN ] HttpTest.SystemCookieWithNullCreationTime [11:27:43:INFO] [0315/112743.287038:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.SystemCookieWithNullCreationTime (34 ms) [11:27:43:INFO] [ RUN ] HttpTest.FilterOutRequest [11:27:43:INFO] [0315/112743.319473:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.FilterOutRequest (30 ms) [11:27:43:INFO] [ RUN ] HttpTest.FileSchemeNotSupported [11:27:43:INFO] [0315/112743.339572:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.FileSchemeNotSupported (19 ms) [11:27:43:INFO] [ RUN ] HttpTest.DataSchemeNotSupported [11:27:43:INFO] [0315/112743.358165:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.DataSchemeNotSupported (18 ms) [11:27:43:INFO] [ RUN ] HttpTest.BrotliAdvertisedTest [11:27:43:INFO] [0315/112743.375006:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [0315/112743.384461:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.BrotliAdvertisedTest (25 ms) [11:27:43:INFO] [ RUN ] HttpTest.BrotliNotAdvertisedTest [11:27:43:INFO] [0315/112743.404179:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [0315/112743.414078:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.BrotliNotAdvertisedTest (29 ms) [11:27:43:INFO] [ RUN ] HttpTest.BrotliHandleDecoding [11:27:43:INFO] [0315/112743.431789:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [0315/112743.442511:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.BrotliHandleDecoding (27 ms) [11:27:43:INFO] [ RUN ] HttpTest.PostRequest [11:27:43:INFO] [0315/112743.463886:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.PostRequest (21 ms) [11:27:43:INFO] [ RUN ] HttpTest.PostRequestWithBodyStream [11:27:43:INFO] [0315/112743.489872:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.PostRequestWithBodyStream (24 ms) [11:27:43:INFO] [ RUN ] HttpTest.PostRequestWithLargeBodyStream [11:27:43:INFO] [0315/112743.514401:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.PostRequestWithLargeBodyStream (23 ms) [11:27:43:INFO] [ RUN ] HttpTest.LegacyApi [11:27:43:INFO] [0315/112743.592056:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] HttpTest.LegacyApi (77 ms) [11:27:43:INFO] [----------] 21 tests from HttpTest (851 ms total) [11:27:43:INFO] [11:27:43:INFO] [----------] 8 tests from CronetEnabledMetricsTest [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsQuic [11:27:43:INFO] [0315/112743.676700:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsQuic (86 ms) [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsNotQuic [11:27:43:INFO] [0315/112743.703789:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsNotQuic (24 ms) [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.PlatformComparison [11:27:43:INFO] [0315/112743.736882:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] CronetEnabledMetricsTest.PlatformComparison (32 ms) [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.InvalidURL [11:27:43:INFO] [0315/112743.754693:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_NAME_NOT_RESOLVED (-105) [11:27:43:INFO] [0315/112743.757737:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] CronetEnabledMetricsTest.InvalidURL (19 ms) [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.CanceledRequest [11:27:43:INFO] [16303:771:0315/112743.775655:11158442336300:WARNING:cronet_test_base.mm(119)] The request was canceled due to timeout. [11:27:43:INFO] [0315/112743.780138:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] CronetEnabledMetricsTest.CanceledRequest (22 ms) [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.ReusedConnection [11:27:43:INFO] [0315/112743.873684:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] CronetEnabledMetricsTest.ReusedConnection (92 ms) [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.SessionWithoutDelegate [11:27:43:INFO] [0315/112743.957901:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:43:INFO] [ OK ] CronetEnabledMetricsTest.SessionWithoutDelegate (83 ms) [11:27:43:INFO] [ RUN ] CronetEnabledMetricsTest.LegacyApi [11:27:44:INFO] [0315/112744.042212:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] CronetEnabledMetricsTest.LegacyApi (83 ms) [11:27:44:INFO] [----------] 8 tests from CronetEnabledMetricsTest (452 ms total) [11:27:44:INFO] [11:27:44:INFO] [----------] 1 test from CronetDisabledMetricsTest [11:27:44:INFO] [ RUN ] CronetDisabledMetricsTest.MetricsDisabled [11:27:44:INFO] [0315/112744.121884:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] CronetDisabledMetricsTest.MetricsDisabled (78 ms) [11:27:44:INFO] [----------] 1 test from CronetDisabledMetricsTest (79 ms total) [11:27:44:INFO] [11:27:44:INFO] [----------] 7 tests from NetLogTest [11:27:44:INFO] [ RUN ] NetLogTest.OpenFile [11:27:44:INFO] [0315/112744.128099:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Documents/cronet_netlog.json [11:27:44:INFO] [0315/112744.140676:WARNING:cronet_environment.mm(186)] Started NetLog [11:27:44:INFO] [0315/112744.140928:WARNING:cronet_environment.mm(202)] Stopped NetLog. [11:27:44:INFO] [0315/112744.148417:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] NetLogTest.OpenFile (23 ms) [11:27:44:INFO] [ RUN ] NetLogTest.CreateFile [11:27:44:INFO] [0315/112744.152815:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Documents/4104D1CE-4350-4DB5-8913-5F9FBB4722CA-16303-00000A261D71B981_netlog.json [11:27:44:INFO] [0315/112744.169455:WARNING:cronet_environment.mm(186)] Started NetLog [11:27:44:INFO] [0315/112744.169740:WARNING:cronet_environment.mm(202)] Stopped NetLog. [11:27:44:INFO] [0315/112744.178109:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] NetLogTest.CreateFile (29 ms) [11:27:44:INFO] [ RUN ] NetLogTest.NonExistantDir [11:27:44:INFO] [0315/112744.181966:ERROR:cronet_environment.mm(158)] Can not start NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Documents/89F662DF-73FC-434B-B2B9-B4C87FD8F9C0-16303-00000A261F314F9C/netlog.json: Undefined error: 0 [11:27:44:INFO] [0315/112744.184042:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] NetLogTest.NonExistantDir (5 ms) [11:27:44:INFO] [ RUN ] NetLogTest.ExistantDir [11:27:44:INFO] [0315/112744.188460:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Documents/B3246645-72CA-42AF-B8C7-81CAFE5C1F80-16303-00000A261F8F23B1/netlog.json [11:27:44:INFO] [0315/112744.205165:WARNING:cronet_environment.mm(186)] Started NetLog [11:27:44:INFO] [0315/112744.205410:WARNING:cronet_environment.mm(202)] Stopped NetLog. [11:27:44:INFO] [0315/112744.213273:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] NetLogTest.ExistantDir (28 ms) [11:27:44:INFO] [ RUN ] NetLogTest.EmptyFilename [11:27:44:INFO] [0315/112744.219353:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] NetLogTest.EmptyFilename (5 ms) [11:27:44:INFO] [ RUN ] NetLogTest.AbsoluteFilename [11:27:44:INFO] [0315/112744.225220:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] NetLogTest.AbsoluteFilename (5 ms) [11:27:44:INFO] [ RUN ] NetLogTest.ExperimentalOptions [11:27:44:INFO] [0315/112744.230727:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [0315/112744.233627:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Documents/cronet_netlog.json [11:27:44:INFO] [0315/112744.248627:WARNING:cronet_environment.mm(186)] Started NetLog [11:27:44:INFO] [0315/112744.248890:WARNING:cronet_environment.mm(202)] Stopped NetLog. [11:27:44:INFO] [0315/112744.259620:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] NetLogTest.ExperimentalOptions (33 ms) [11:27:44:INFO] [----------] 7 tests from NetLogTest (136 ms total) [11:27:44:INFO] [11:27:44:INFO] [----------] 12 tests from PkpTest [11:27:44:INFO] [ RUN ] PkpTest.TestSuccessIfPinSetForDifferentHost [11:27:44:INFO] [0315/112744.338001:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestSuccessIfPinSetForDifferentHost (78 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestErrorIfPinDoesNotMatch [11:27:44:INFO] [0315/112744.377427:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [11:27:44:INFO] [0315/112744.378503:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_QUIC_PROTOCOL_ERROR (-356) [11:27:44:INFO] [0315/112744.398826:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestErrorIfPinDoesNotMatch (60 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestSuccessIfPinMatches [11:27:44:INFO] [0315/112744.478831:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestSuccessIfPinMatches (79 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestBypass [11:27:44:INFO] [ OK ] PkpTest.TestBypass (11 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualTrue [11:27:44:INFO] [0315/112744.530670:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [11:27:44:INFO] [0315/112744.531514:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_QUIC_PROTOCOL_ERROR (-356) [11:27:44:INFO] [0315/112744.548238:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualTrue (55 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualFalse [11:27:44:INFO] [0315/112744.625455:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualFalse (76 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestSoonExpiringPin [11:27:44:INFO] [0315/112744.667509:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [11:27:44:INFO] [0315/112744.668422:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_QUIC_PROTOCOL_ERROR (-356) [11:27:44:INFO] [0315/112744.683902:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestSoonExpiringPin (58 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestRecentlyExpiredPin [11:27:44:INFO] [0315/112744.762039:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestRecentlyExpiredPin (76 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestPinsAreNotPersisted [11:27:44:INFO] [0315/112744.807524:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [11:27:44:INFO] [0315/112744.809900:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [11:27:44:INFO] [0315/112744.828195:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [0315/112744.889233:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestPinsAreNotPersisted (126 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestHashLengthError [11:27:44:INFO] [ OK ] PkpTest.TestHashLengthError (10 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestPkpOverrideNonMatchingToMatching [11:27:44:INFO] [0315/112744.985235:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:44:INFO] [ OK ] PkpTest.TestPkpOverrideNonMatchingToMatching (84 ms) [11:27:44:INFO] [ RUN ] PkpTest.TestPkpOverrideMatchingToNonMatching [11:27:45:INFO] [0315/112745.027347:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [11:27:45:INFO] [0315/112745.028214:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_QUIC_PROTOCOL_ERROR (-356) [11:27:45:INFO] [0315/112745.058633:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:27:45:INFO] [ OK ] PkpTest.TestPkpOverrideMatchingToNonMatching (73 ms) [11:27:45:INFO] [----------] 12 tests from PkpTest (800 ms total) [11:27:45:INFO] [11:27:45:INFO] [----------] 1 test from PrefsTest [11:27:45:INFO] [ RUN ] PrefsTest.HttpSeverProperties [11:27:45:INFO] 2019-03-15 11:27:45.118 cronet_test[16303:330136] Waiting for file /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Library/Caches/cronet/prefs/local_prefs.json. [11:27:45:INFO] 2019-03-15 11:27:45.118 cronet_test[16303:330136] Time left: 80 seconds [11:27:50:INFO] 2019-03-15 11:27:50.119 cronet_test[16303:330136] Time left: 75 seconds [11:27:55:INFO] 2019-03-15 11:27:55.121 cronet_test[16303:330136] Time left: 70 seconds [11:28:00:INFO] 2019-03-15 11:28:00.122 cronet_test[16303:330136] Time left: 65 seconds [11:28:05:INFO] 2019-03-15 11:28:05.125 cronet_test[16303:330136] Time left: 60 seconds [11:28:10:INFO] 2019-03-15 11:28:10.126 cronet_test[16303:330136] Time left: 55 seconds [11:28:15:INFO] 2019-03-15 11:28:15.129 cronet_test[16303:330136] Time left: 50 seconds [11:28:20:INFO] 2019-03-15 11:28:20.131 cronet_test[16303:330136] Time left: 45 seconds [11:28:25:INFO] 2019-03-15 11:28:25.134 cronet_test[16303:330136] Time left: 40 seconds [11:28:30:INFO] 2019-03-15 11:28:30.136 cronet_test[16303:330136] Time left: 35 seconds [11:28:35:INFO] 2019-03-15 11:28:35.137 cronet_test[16303:330136] Time left: 30 seconds [11:28:40:INFO] 2019-03-15 11:28:40.140 cronet_test[16303:330136] Time left: 25 seconds [11:28:45:INFO] 2019-03-15 11:28:45.142 cronet_test[16303:330136] Time left: 20 seconds [11:28:50:INFO] 2019-03-15 11:28:50.145 cronet_test[16303:330136] Time left: 15 seconds [11:28:55:INFO] 2019-03-15 11:28:55.148 cronet_test[16303:330136] File /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159/data/Containers/Data/Application/2734C005-1CFA-4EBB-A7DF-0CD3CB9D09EF/Library/Caches/cronet/prefs/local_prefs.json exists. [11:28:55:INFO] [0315/112855.153236:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:28:55:INFO] [ OK ] PrefsTest.HttpSeverProperties (70093 ms) [11:28:55:INFO] [----------] 1 test from PrefsTest (70094 ms total) [11:28:55:INFO] [11:28:55:INFO] [----------] 3 tests from QuicTest [11:28:55:INFO] [ RUN ] QuicTest.InvalidQuicHost [11:28:55:INFO] [0315/112855.161938:ERROR:Cronet.mm(218)] Invalid QUIC hint host: https://test.example.com/ [11:28:55:INFO] [ OK ] QuicTest.InvalidQuicHost (7 ms) [11:28:55:INFO] [ RUN ] QuicTest.ValidQuicHost [11:28:55:INFO] [ OK ] QuicTest.ValidQuicHost (7 ms) [11:28:55:INFO] [ RUN ] QuicTest.RequestWithSocketOptimizationEnabled [11:28:55:INFO] [0315/112855.224051:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:28:55:INFO] [ OK ] QuicTest.RequestWithSocketOptimizationEnabled (53 ms) [11:28:55:INFO] [----------] 3 tests from QuicTest (72 ms total) [11:28:55:INFO] [11:28:55:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 (39 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 (39 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 (39 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 (36 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 (37 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 (39 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 (39 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1 (38 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 (37 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 (37 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 [11:28:55:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 (37 ms) [11:28:55:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 (37 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 [11:28:56:INFO] [0315/112856.024179:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 (9 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 [11:28:56:INFO] [0315/112856.034353:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 (9 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0 (39 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1 (39 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 [11:28:56:INFO] [0315/112856.125260:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 (9 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 [11:28:56:INFO] [0315/112856.135473:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 (9 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 (36 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 (37 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 [11:28:56:INFO] [0315/112856.251291:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed. [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 (37 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 [11:28:56:INFO] [0315/112856.290584:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed. [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 (38 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 (9 ms) [11:28:56:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 [11:28:56:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 (9 ms) [11:28:56:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest (1089 ms total) [11:28:56:INFO] [11:28:56:INFO] [----------] 5 tests from Loops/PerfTest [11:28:56:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0 [11:28:56:INFO] [16303:771:0315/112856.324487:11230989019481:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 0 AKD4: 0 Cronet: 0 [11:28:56:INFO] [16303:771:0315/112856.324664:11230989134792:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [11:28:56:INFO] [16303:771:0315/112856.929253:11231593733282:INFO:cronet_performance_test.mm(253)] Elapsed Total:589.362ms [11:28:56:INFO] [0315/112856.933134:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:28:56:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0 (617 ms) [11:28:56:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1 [11:28:56:INFO] [16303:771:0315/112856.944259:11231608729667:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 0 AKD4: 0 Cronet: 1 [11:28:56:INFO] [16303:771:0315/112856.944370:11231608821586:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [11:28:57:INFO] [16303:771:0315/112857.490918:11232155385319:INFO:cronet_performance_test.mm(253)] Elapsed Total:531.839ms [11:28:57:INFO] [0315/112857.494717:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:28:57:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1 (560 ms) [11:28:57:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2 [11:28:57:INFO] [16303:771:0315/112857.505828:11232170289607:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 1 AKD4: 0 Cronet: 1 [11:28:57:INFO] [16303:771:0315/112857.505949:11232170389215:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [11:28:58:INFO] [16303:771:0315/112858.049615:11232714084293:INFO:cronet_performance_test.mm(253)] Elapsed Total:529.095ms [11:28:58:INFO] [0315/112858.053267:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:28:58:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2 (557 ms) [11:28:58:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3 [11:28:58:INFO] [16303:771:0315/112858.064739:11232729202225:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1 HTTP2: 0 AKD4: 0 Cronet: 1 [11:28:58:INFO] [16303:771:0315/112858.064898:11232729324951:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [11:28:58:INFO] [16303:771:0315/112858.634874:11233299346051:INFO:cronet_performance_test.mm(253)] Elapsed Total:554.96ms [11:28:58:INFO] [0315/112858.638675:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:28:58:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3 (584 ms) [11:28:58:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4 [11:28:58:INFO] [16303:771:0315/112858.650340:11233314764181:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1 HTTP2: 0 AKD4: 1 Cronet: 1 [11:28:58:INFO] [16303:771:0315/112858.650457:11233314865535:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [11:28:59:INFO] [16303:771:0315/112859.203424:11233867889860:INFO:cronet_performance_test.mm(253)] Elapsed Total:537.578ms [11:28:59:INFO] [0315/112859.207295:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [11:28:59:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4 (567 ms) [11:28:59:INFO] [16303:771:0315/112859.209687:11233874100666:INFO:cronet_performance_test.mm(71)] Performance Data: [11:28:59:INFO] [16303:771:0315/112859.209829:11233874216297:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 0 AKD4 0 Cronet 0: Mean: 0.058936s (2620.791197mbps) Max: 0.062045s with 0 fails out of 10 total requests. [11:28:59:INFO] [16303:771:0315/112859.209925:11233874304613:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 0 AKD4 0 Cronet 1: Mean: 0.053184s (2904.253133mbps) Max: 0.055914s with 0 fails out of 10 total requests. [11:28:59:INFO] [16303:771:0315/112859.210015:11233874404169:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 1 AKD4 0 Cronet 1: Mean: 0.052909s (2919.316961mbps) Max: 0.057606s with 0 fails out of 10 total requests. [11:28:59:INFO] [16303:771:0315/112859.210120:11233874510394:INFO:cronet_performance_test.mm(88)] Quic 1 Http2 0 AKD4 0 Cronet 1: Mean: 0.055496s (2783.253607mbps) Max: 0.059006s with 0 fails out of 10 total requests. [11:28:59:INFO] [16303:771:0315/112859.210208:11233874586538:INFO:cronet_performance_test.mm(88)] Quic 1 Http2 0 AKD4 1 Cronet 1: Mean: 0.053758s (2873.247181mbps) Max: 0.059427s with 0 fails out of 10 total requests. [11:28:59:INFO] [----------] 5 tests from Loops/PerfTest (2893 ms total) [11:28:59:INFO] [11:28:59:INFO] [----------] Global test environment tear-down [11:28:59:INFO] [==========] 166 tests from 14 test suites ran. (81283 ms total) [11:28:59:INFO] [ PASSED ] 166 tests. [11:28:59:INFO] [11:28:59:INFO] YOU HAVE 2 DISABLED TESTS [11:28:59:INFO] [11:29:13:INFO] Testing started on 'iPhone X' [11:29:13:INFO] 2019-03-15 11:27:12.348 xcodebuild[16177:328544] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [11:29:13:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-bscduslnxibqwvaccrqzkphldlen/Logs/Test/Test-Transient Testing-2019.03.15_11-27-12--0700.xcresult/1_Test/Diagnostics/cronet_test-64600455-A308-4CC6-8375-79CC0F0463ED/cronet_test-791B3444-FC67-4878-A649-0487F3082343/Session-cronet_test-2019-03-15_112712-2arzYa.log [11:29:13:INFO] 2019-03-15 11:27:12.348 xcodebuild[16177:328518] [MT] IDETestOperationsObserverDebug: (EA728DA5-1AB5-4E45-A68D-6431CDB322DD) Beginning test session cronet_test-EA728DA5-1AB5-4E45-A68D-6431CDB322DD at 2019-03-15 11:27:12.348 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fc8557e8890> { [11:29:13:INFO] SimDevice: iPhone X (E7FA2AEF-84B5-4CAC-B05C-8B27DC84F159, iOS 11.4, Shutdown) [11:29:13:INFO] } (11.4 (15F79)) [11:29:13:INFO] 2019-03-15 11:29:08.930 xcodebuild[16177:328518] [MT] IDETestOperationsObserverDebug: 116.658 elapsed -- Testing started completed. [11:29:13:INFO] 2019-03-15 11:29:08.930 xcodebuild[16177:328518] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [11:29:13:INFO] 2019-03-15 11:29:08.931 xcodebuild[16177:328518] [MT] IDETestOperationsObserverDebug: 116.658 sec, +116.658 sec -- end [11:29:13:INFO] [11:29:13:INFO] Testing failed: [11:29:13:INFO] cronet_test.app (16303) encountered an error (Early unexpected exit, operation never finished bootstrapping - no restart will be attempted. (Underlying error: Test runner exited before starting test execution.)) [11:29:13:DEBUG] Finished print_process_output. [11:29:13:INFO] Waiting for test process to terminate. [11:29:13:INFO] Test process terminated. [11:29:13:DEBUG] Setting sigterm handler. [11:29:13:DEBUG] Stdout flushed after test process. [11:29:13:DEBUG] Processing test results. [11:29:13:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 65 [11:29:13:DEBUG] Extracting test data. [11:29:13:DEBUG] Retrieving crash reports. [11:29:13:DEBUG] Retrieving derived data. [11:29:13:DEBUG] Making desktop screenshots. [11:29:13:DEBUG] Killing simulators. [11:29:18:DEBUG] Wiping simulator. Device wiped. [11:29:20:DEBUG] End of tear_down. 2019-03-15 11:30:26,001 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/5FJQnyh/439b6072a0ac8e10'] 2019-03-15 11:30:26,001 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/5FJQnyh/439b6072a0ac8e10/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/5FJQnyh/439b6072a0ac8e10/output.json'] 2019-03-15 11:30:26,001 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/5FJQnyh' Found ['/b/s/w/ir/k/recipe_cleanup/5FJQnyh/439b6072a0ac8e10'] 2019-03-15 11:30:26,001 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/5FJQnyh/439b6072a0ac8e10/output.json'] 2019-03-15 11:30:26,001 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/5b0713/bin/python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --summary-json /b/s/w/ir/tmp/t/tmpuwDMpU.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/5FJQnyh -o /b/s/w/ir/tmp/t/tmpRvC7cS.json Running ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpuwDMpU.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/5FJQnyh', '-o', '/b/s/w/ir/tmp/t/tmpRvC7cS.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpuwDMpU.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/5FJQnyh', '-o', '/b/s/w/ir/tmp/t/tmpRvC7cS.json'] returned exit code 0