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

{ "shards": [ { "bot_dimensions": [ { "key": "caches", "value": [ "swarming_module_cache_vpython", "xcode_ios_10b61", "xcode_ios_10l232m", "xcode_ios_10o45e" ] }, { "key": "cores", "value": [ "8" ] }, { "key": "cpu", "value": [ "x86", "x86-64", "x86-64-E5-2697_v2" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "gpu", "value": [ "none" ] }, { "key": "id", "value": [ "vm955-m4" ] }, { "key": "mac_model", "value": [ "VMware7,1" ] }, { "key": "machine_type", "value": [ "n1-highcpu-8" ] }, { "key": "os", "value": [ "Mac", "Mac-10.13", "Mac-10.13.6" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.10" ] }, { "key": "server_version", "value": [ "4201-b04f7f8" ] }, { "key": "ssd", "value": [ "1" ] }, { "key": "zone", "value": [ "us", "us-golo", "us-golo-4" ] } ], "bot_id": "vm955-m4", "bot_version": "51d929b905e4fffb3652f17e0ff8dceb0f7077275d215d276fb6c5a2f238b3f7", "cipd_pins": { "client_package": { "package_name": "infra/tools/cipd/mac-amd64", "version": "1vQ99wQk82cRyVYu18rqMpXtb7XZ3WHvL3HFXTcLHN4C" }, "packages": [ { "package_name": "infra/tools/mac_toolchain/mac-amd64", "path": ".", "version": "1065f97353165dfafa89b64bfdaf9b424d705bc7" }, { "package_name": "infra/python/cpython/mac-amd64", "path": ".swarming_module", "version": "6dd10e31dc5d4cbb3c8f42a6fbd9485aeeb9ef0c" }, { "package_name": "infra/tools/luci/logdog/butler/mac-amd64", "path": ".swarming_module", "version": "3138aa2054ab30eac6f7e1e589e590571ae44692" }, { "package_name": "infra/tools/luci/vpython-native/mac-amd64", "path": ".swarming_module", "version": "LH2D9eSe-sJImw8pxSsKdnKz9LueOAM77FFBJMvP8BwC" }, { "package_name": "infra/tools/luci/vpython/mac-amd64", "path": ".swarming_module", "version": "yhDQeJa8hj64DkPAcLKVNQmNTgYsirl5_wvmnHvOz9cC" } ] }, "completed_ts": "2019-03-15T18:30:03.373088", "costs_usd": [ 0.04691782344728693 ], "created_ts": "2019-03-15T18:13:14.486091", "duration": 139.9358298778534, "modified_ts": "2019-03-15T18:30:03.373088", "name": "cronet_test (iPhone 5s iOS 9.3)/Mac-10.13.6/3403140469/ios-simulator-cronet/69659", "output": "[I 2019-03-15 11:26:45] About to install Xcode 10b61 in Xcode.app for ios\n[11:26:47:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer\nDevice wiped.\n[11:26:56:DEBUG] Setting sigterm handler.\n[11:26:58:INFO] User defaults from command line:\n[11:26:58:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/372C96FE-68CC-4C41-84E5-E1E2E61BCFA2\n[11:26:58:INFO] \n[11:27:23:INFO] objc[22623]: Class CRBProtocolObservers is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Bundle/Application/2F8617D8-DFC5-4680-B4B8-A534B1F1D557/cronet_test.app/Frameworks/Cronet.framework/Cronet and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Bundle/Application/2F8617D8-DFC5-4680-B4B8-A534B1F1D557/cronet_test.app/cronet_test. One of the two will be used. Which one is undefined.\n[11:27:23:INFO] objc[22623]: Class CRBWeakNSProtocolSentinel is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Bundle/Application/2F8617D8-DFC5-4680-B4B8-A534B1F1D557/cronet_test.app/Frameworks/Cronet.framework/Cronet and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Bundle/Application/2F8617D8-DFC5-4680-B4B8-A534B1F1D557/cronet_test.app/cronet_test. One of the two will be used. Which one is undefined.\n[11:27:23:INFO] [==========] Running 166 tests from 14 test suites.\n[11:27:23:INFO] [----------] Global test environment set-up.\n[11:27:23:INFO] [----------] 4 tests from BufferTest\n[11:27:23:INFO] [ RUN ] BufferTest.TestInitWithAlloc\n[11:27:23:INFO] [ OK ] BufferTest.TestInitWithAlloc (14 ms)\n[11:27:23:INFO] [ RUN ] BufferTest.TestInitWithHugeAllocFails\n[11:27:23:INFO] [ OK ] BufferTest.TestInitWithHugeAllocFails (0 ms)\n[11:27:23:INFO] [ RUN ] BufferTest.TestInitWithDataAndCallback\n[11:27:23:INFO] [ OK ] BufferTest.TestInitWithDataAndCallback (1 ms)\n[11:27:23:INFO] [ RUN ] BufferTest.TestCronetBufferAsync\n[11:27:23:INFO] [ OK ] BufferTest.TestCronetBufferAsync (4 ms)\n[11:27:23:INFO] [----------] 4 tests from BufferTest (26 ms total)\n[11:27:23:INFO] \n[11:27:23:INFO] [----------] 8 tests from EngineTest\n[11:27:23:INFO] [ RUN ] EngineTest.StartCronetEngine\n[11:27:23:INFO] [ OK ] EngineTest.StartCronetEngine (119 ms)\n[11:27:23:INFO] [ RUN ] EngineTest.CronetEngineDefaultUserAgent\n[11:27:23:INFO] [ OK ] EngineTest.CronetEngineDefaultUserAgent (1 ms)\n[11:27:23:INFO] [ RUN ] EngineTest.InitDifferentEngines\n[11:27:23:INFO] [ OK ] EngineTest.InitDifferentEngines (6 ms)\n[11:27:23:INFO] [ RUN ] EngineTest.StartResults\n[11:27:23:INFO] [0315/112723.925340:ERROR:engine.cc(135)] Disk cache path /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/tmp/.org.chromium.Chromium.vS4H7n is already used, cache disabled.\n[11:27:24:INFO] [ OK ] EngineTest.StartResults (130 ms)\n[11:27:24:INFO] [ RUN ] EngineTest.InvalidPkpParams\n[11:27:24:INFO] [ OK ] EngineTest.InvalidPkpParams (0 ms)\n[11:27:24:INFO] [ RUN ] EngineTest.ValidPkpParams\n[11:27:24:INFO] [ OK ] EngineTest.ValidPkpParams (5 ms)\n[11:27:24:INFO] [ RUN ] EngineTest.SetMockCertVerifierForTesting\n[11:27:24:INFO] [ OK ] EngineTest.SetMockCertVerifierForTesting (2 ms)\n[11:27:24:INFO] [ RUN ] EngineTest.StartNetLogToFile\n[11:27:24:INFO] [0315/112724.108480:ERROR:cronet_url_request_context.cc(536)] Failed to open NetLog file for writing.\n[11:27:24:INFO] [ OK ] EngineTest.StartNetLogToFile (45 ms)\n[11:27:24:INFO] [----------] 8 tests from EngineTest (319 ms total)\n[11:27:24:INFO] \n[11:27:24:INFO] [----------] 2 tests from ExecutorsTest\n[11:27:24:INFO] [ RUN ] ExecutorsTest.TestCustom\n[11:27:24:INFO] [ OK ] ExecutorsTest.TestCustom (1 ms)\n[11:27:24:INFO] [ RUN ] ExecutorsTest.TestTestExecutor\n[11:27:24:INFO] [ OK ] ExecutorsTest.TestTestExecutor (0 ms)\n[11:27:24:INFO] [----------] 2 tests from ExecutorsTest (4 ms total)\n[11:27:24:INFO] \n[11:27:24:INFO] [----------] 57 tests from UrlRequestTest\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithDirectExecutor\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithDirectExecutor (44 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.InitChecks/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.InitChecks/0 (4 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.InitChecks/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.InitChecks/1 (4 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.SimpleGet/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.SimpleGet/0 (7 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.SimpleGet/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.SimpleGet/1 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadEmptyBodySync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadEmptyBodySync/0 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadEmptyBodySync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadEmptyBodySync/1 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadSync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadSync/0 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadSync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadSync/1 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.SSLCertificateError/0\n[11:27:24:INFO] [0315/112724.311111:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207\n[11:27:24:INFO] [22623:39471:0315/112724.311743:42681844471918:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117\n[11:27:24:INFO] [ OK ] UrlRequestTest.SSLCertificateError/0 (84 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.SSLCertificateError/1\n[11:27:24:INFO] [0315/112724.344794:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207\n[11:27:24:INFO] [22623:29759:0315/112724.344996:42681877672820:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117\n[11:27:24:INFO] [ OK ] UrlRequestTest.SSLCertificateError/1 (31 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesSync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesSync/0 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesSync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesSync/1 (13 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesAsync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesAsync/0 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesAsync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesAsync/1 (13 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadChangesDefaultMethod/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadChangesDefaultMethod/0 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadChangesDefaultMethod/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadChangesDefaultMethod/1 (11 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithSetMethod/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithSetMethod/0 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithSetMethod/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithSetMethod/1 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithBigRead/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithBigRead/0 (10 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithBigRead/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithBigRead/1 (10 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRedirectSync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRedirectSync/0 (11 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRedirectSync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRedirectSync/1 (12 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRedirectAsync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRedirectAsync/0 (11 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRedirectAsync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRedirectAsync/1 (15 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithBadLength/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithBadLength/0 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithBadLength/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithBadLength/1 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithBadLengthBufferAligned/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithBadLengthBufferAligned/0 (89 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadWithBadLengthBufferAligned/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadWithBadLengthBufferAligned/1 (173 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadReadFailSync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadReadFailSync/0 (7 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadReadFailSync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadReadFailSync/1 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadReadFailAsync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadReadFailAsync/0 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadReadFailAsync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadReadFailAsync/1 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRewindFailSync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRewindFailSync/0 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRewindFailSync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRewindFailSync/1 (11 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRewindFailAsync/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRewindFailAsync/0 (10 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadRewindFailAsync/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadRewindFailAsync/1 (13 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadChunked/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadChunked/0 (10 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadChunked/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadChunked/1 (11 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 (8 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 (12 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadFailsWithoutInitializingStream/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadFailsWithoutInitializingStream/0 (6 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.UploadFailsWithoutInitializingStream/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.UploadFailsWithoutInitializingStream/1 (7 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.SimpleRequest/0\n[11:27:24:INFO] [ OK ] UrlRequestTest.SimpleRequest/0 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.SimpleRequest/1\n[11:27:24:INFO] [ OK ] UrlRequestTest.SimpleRequest/1 (9 ms)\n[11:27:24:INFO] [ RUN ] UrlRequestTest.MultiRedirect/0\n[11:27:25:INFO] [ OK ] UrlRequestTest.MultiRedirect/0 (18 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.MultiRedirect/1\n[11:27:25:INFO] [ OK ] UrlRequestTest.MultiRedirect/1 (16 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.CancelRequest/0\n[11:27:25:INFO] [ OK ] UrlRequestTest.CancelRequest/0 (8 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.CancelRequest/1\n[11:27:25:INFO] [ OK ] UrlRequestTest.CancelRequest/1 (9 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.FailedRequestHostNotFound/0\n[11:27:25:INFO] [ OK ] UrlRequestTest.FailedRequestHostNotFound/0 (7 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.FailedRequestHostNotFound/1\n[11:27:25:INFO] [ OK ] UrlRequestTest.FailedRequestHostNotFound/1 (7 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.TestCancel/0\n[11:27:25:INFO] [ OK ] UrlRequestTest.TestCancel/0 (84 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.TestCancel/1\n[11:27:25:INFO] [ OK ] UrlRequestTest.TestCancel/1 (84 ms)\n[11:27:25:INFO] [ RUN ] UrlRequestTest.PerfTest/0\n[11:27:26:INFO] [22623:771:0315/112726.578663:42684111476823:INFO:url_request_test.cc(993)] Total time 1304.92 ms\n[11:27:26:INFO] [22623:771:0315/112726.578877:42684111682221:INFO:url_request_test.cc(994)] Single Iteration time 130.492 ms\n[11:27:26:INFO] [22623:771:0315/112726.579046:42684111875875:INFO:url_request_test.cc(1001)] Average Throughput: 1183.67 mbps\n[11:27:26:INFO] [ OK ] UrlRequestTest.PerfTest/0 (1351 ms)\n[11:27:26:INFO] [ RUN ] UrlRequestTest.PerfTest/1\n[11:27:28:INFO] [22623:771:0315/112728.906748:42686439697234:INFO:url_request_test.cc(993)] Total time 2303.24 ms\n[11:27:28:INFO] [22623:771:0315/112728.906960:42686439880477:INFO:url_request_test.cc(994)] Single Iteration time 230.324 ms\n[11:27:28:INFO] [22623:771:0315/112728.907101:42686440044176:INFO:url_request_test.cc(1001)] Average Throughput: 670.619 mbps\n[11:27:28:INFO] [ OK ] UrlRequestTest.PerfTest/1 (2327 ms)\n[11:27:28:INFO] [ RUN ] UrlRequestTest.GetStatus/0\n[11:27:28:INFO] [ OK ] UrlRequestTest.GetStatus/0 (10 ms)\n[11:27:28:INFO] [ RUN ] UrlRequestTest.GetStatus/1\n[11:27:28:INFO] [ OK ] UrlRequestTest.GetStatus/1 (11 ms)\n[11:27:28:INFO] [----------] 57 tests from UrlRequestTest (4823 ms total)\n[11:27:28:INFO] \n[11:27:28:INFO] [----------] 5 tests from AcceptLangTest\n[11:27:28:INFO] [ RUN ] AcceptLangTest.Region\n[11:27:28:INFO] [ OK ] AcceptLangTest.Region (0 ms)\n[11:27:28:INFO] [ RUN ] AcceptLangTest.Lang\n[11:27:28:INFO] [ OK ] AcceptLangTest.Lang (0 ms)\n[11:27:28:INFO] [ RUN ] AcceptLangTest.Default\n[11:27:28:INFO] [ OK ] AcceptLangTest.Default (0 ms)\n[11:27:28:INFO] [ RUN ] AcceptLangTest.Append\n[11:27:28:INFO] [ OK ] AcceptLangTest.Append (0 ms)\n[11:27:28:INFO] [ RUN ] AcceptLangTest.NoDefaultAppend\n[11:27:28:INFO] 2019-03-15 11:27:28.945 cronet_test[22623:1832005] en-GB,en-US,en\n[11:27:28:INFO] [ OK ] AcceptLangTest.NoDefaultAppend (1 ms)\n[11:27:28:INFO] [----------] 5 tests from AcceptLangTest (8 ms total)\n[11:27:28:INFO] \n[11:27:28:INFO] [----------] 21 tests from HttpTest\n[11:27:28:INFO] [ RUN ] HttpTest.CreateSslKeyLogFile\n[11:27:28:INFO] 2019-03-15 11:27:28.975 cronet_test[22623:1832515] DiskCookieStorage changing policy from 2 to 0, cookie file: file:///Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Library/Cookies/org.chromium.gtest.cronet-test.binarycookies\n[11:27:29:INFO] [0315/112729.004420:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [0315/112729.011014:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.CreateSslKeyLogFile (67 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.NSURLSessionReceivesData\n[11:27:29:INFO] [0315/112729.128905:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.NSURLSessionReceivesData (115 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.GetGlobalMetricsDeltas\n[11:27:29:INFO] [0315/112729.209279:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.GetGlobalMetricsDeltas (79 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.SdchDisabledByDefault\n[11:27:29:INFO] [0315/112729.234166:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.SdchDisabledByDefault (23 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.AcceptEncodingSdchIsAllowed\n[11:27:29:INFO] [0315/112729.256607:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.AcceptEncodingSdchIsAllowed (21 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.AcceptEncodingFooBarIsAllowed\n[11:27:29:INFO] [0315/112729.282716:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.AcceptEncodingFooBarIsAllowed (25 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.NSURLSessionAcceptLanguage\n[11:27:29:INFO] [0315/112729.308354:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.NSURLSessionAcceptLanguage (24 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.SetUserAgentIsExact\n[11:27:29:INFO] [0315/112729.333824:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.SetUserAgentIsExact (24 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.SetCookie\n[11:27:29:INFO] [0315/112729.370379:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.SetCookie (35 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.SetSystemCookie\n[11:27:29:INFO] [0315/112729.393905:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.SetSystemCookie (22 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.SystemCookieWithNullCreationTime\n[11:27:29:INFO] [0315/112729.420630:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.SystemCookieWithNullCreationTime (26 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.FilterOutRequest\n[11:27:29:INFO] [0315/112729.451845:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.FilterOutRequest (30 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.FileSchemeNotSupported\n[11:27:29:INFO] [0315/112729.471956:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.FileSchemeNotSupported (19 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.DataSchemeNotSupported\n[11:27:29:INFO] [0315/112729.489452:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.DataSchemeNotSupported (16 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.BrotliAdvertisedTest\n[11:27:29:INFO] [0315/112729.506872:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [0315/112729.517222:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.BrotliAdvertisedTest (26 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.BrotliNotAdvertisedTest\n[11:27:29:INFO] [0315/112729.532614:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [0315/112729.543538:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.BrotliNotAdvertisedTest (26 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.BrotliHandleDecoding\n[11:27:29:INFO] [0315/112729.562503:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [0315/112729.575413:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.BrotliHandleDecoding (30 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.PostRequest\n[11:27:29:INFO] [0315/112729.598209:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.PostRequest (21 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.PostRequestWithBodyStream\n[11:27:29:INFO] [0315/112729.622732:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.PostRequestWithBodyStream (22 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.PostRequestWithLargeBodyStream\n[11:27:29:INFO] [0315/112729.647236:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.PostRequestWithLargeBodyStream (23 ms)\n[11:27:29:INFO] [ RUN ] HttpTest.LegacyApi\n[11:27:29:INFO] [0315/112729.717331:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] HttpTest.LegacyApi (68 ms)\n[11:27:29:INFO] [----------] 21 tests from HttpTest (773 ms total)\n[11:27:29:INFO] \n[11:27:29:INFO] [----------] 8 tests from CronetEnabledMetricsTest\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsQuic\n[11:27:29:INFO] [0315/112729.732949:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsQuic (15 ms)\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsNotQuic\n[11:27:29:INFO] [0315/112729.751391:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsNotQuic (18 ms)\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.PlatformComparison\n[11:27:29:INFO] [0315/112729.768086:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.PlatformComparison (15 ms)\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.InvalidURL\n[11:27:29:INFO] [0315/112729.784072:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.InvalidURL (15 ms)\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.CanceledRequest\n[11:27:29:INFO] [0315/112729.800422:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.CanceledRequest (15 ms)\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.ReusedConnection\n[11:27:29:INFO] [0315/112729.819580:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.ReusedConnection (17 ms)\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.SessionWithoutDelegate\n[11:27:29:INFO] [0315/112729.838903:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.SessionWithoutDelegate (18 ms)\n[11:27:29:INFO] [ RUN ] CronetEnabledMetricsTest.LegacyApi\n[11:27:29:INFO] [0315/112729.902326:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetEnabledMetricsTest.LegacyApi (61 ms)\n[11:27:29:INFO] [----------] 8 tests from CronetEnabledMetricsTest (186 ms total)\n[11:27:29:INFO] \n[11:27:29:INFO] [----------] 1 test from CronetDisabledMetricsTest\n[11:27:29:INFO] [ RUN ] CronetDisabledMetricsTest.MetricsDisabled\n[11:27:29:INFO] [0315/112729.919913:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] CronetDisabledMetricsTest.MetricsDisabled (16 ms)\n[11:27:29:INFO] [----------] 1 test from CronetDisabledMetricsTest (18 ms total)\n[11:27:29:INFO] \n[11:27:29:INFO] [----------] 7 tests from NetLogTest\n[11:27:29:INFO] [ RUN ] NetLogTest.OpenFile\n[11:27:29:INFO] [0315/112729.926833:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Documents/cronet_netlog.json\n[11:27:29:INFO] [0315/112729.944033:WARNING:cronet_environment.mm(186)] Started NetLog\n[11:27:29:INFO] [0315/112729.944394:WARNING:cronet_environment.mm(202)] Stopped NetLog.\n[11:27:29:INFO] [0315/112729.951197:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] NetLogTest.OpenFile (27 ms)\n[11:27:29:INFO] [ RUN ] NetLogTest.CreateFile\n[11:27:29:INFO] [0315/112729.954979:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Documents/AAA1D968-1EA6-4BAB-B844-6629ACD46A36-22623-000026D2F488DA65_netlog.json\n[11:27:29:INFO] [0315/112729.972219:WARNING:cronet_environment.mm(186)] Started NetLog\n[11:27:29:INFO] [0315/112729.972500:WARNING:cronet_environment.mm(202)] Stopped NetLog.\n[11:27:29:INFO] [0315/112729.980092:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] NetLogTest.CreateFile (28 ms)\n[11:27:29:INFO] [ RUN ] NetLogTest.NonExistantDir\n[11:27:29:INFO] [0315/112729.984627:ERROR:cronet_environment.mm(158)] Can not start NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Documents/E1EC1CA6-9972-4F1D-ABD2-45536AF78326-22623-000026D2F64F4CC3/netlog.json: Undefined error: 0\n[11:27:29:INFO] [0315/112729.986931:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:29:INFO] [ OK ] NetLogTest.NonExistantDir (6 ms)\n[11:27:29:INFO] [ RUN ] NetLogTest.ExistantDir\n[11:27:29:INFO] [0315/112729.991250:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Documents/061349C8-1F7A-4A68-9459-8AA7699DC20D-22623-000026D2F6AFC46D/netlog.json\n[11:27:30:INFO] [0315/112730.002308:WARNING:cronet_environment.mm(186)] Started NetLog\n[11:27:30:INFO] [0315/112730.002607:WARNING:cronet_environment.mm(202)] Stopped NetLog.\n[11:27:30:INFO] [0315/112730.011203:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] NetLogTest.ExistantDir (23 ms)\n[11:27:30:INFO] [ RUN ] NetLogTest.EmptyFilename\n[11:27:30:INFO] [0315/112730.016785:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] NetLogTest.EmptyFilename (3 ms)\n[11:27:30:INFO] [ RUN ] NetLogTest.AbsoluteFilename\n[11:27:30:INFO] [0315/112730.022587:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] NetLogTest.AbsoluteFilename (4 ms)\n[11:27:30:INFO] [ RUN ] NetLogTest.ExperimentalOptions\n[11:27:30:INFO] [0315/112730.029601:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [0315/112730.032167:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Documents/cronet_netlog.json\n[11:27:30:INFO] [0315/112730.049431:WARNING:cronet_environment.mm(186)] Started NetLog\n[11:27:30:INFO] [0315/112730.049785:WARNING:cronet_environment.mm(202)] Stopped NetLog.\n[11:27:30:INFO] [0315/112730.057415:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] NetLogTest.ExperimentalOptions (33 ms)\n[11:27:30:INFO] [----------] 7 tests from NetLogTest (135 ms total)\n[11:27:30:INFO] \n[11:27:30:INFO] [----------] 12 tests from PkpTest\n[11:27:30:INFO] [ RUN ] PkpTest.TestSuccessIfPinSetForDifferentHost\n[11:27:30:INFO] [0315/112730.118787:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestSuccessIfPinSetForDifferentHost (61 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestErrorIfPinDoesNotMatch\n[11:27:30:INFO] [0315/112730.154665:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN\n[11:27:30:INFO] [0315/112730.157470:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102)\n[11:27:30:INFO] [0315/112730.165508:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestErrorIfPinDoesNotMatch (44 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestSuccessIfPinMatches\n[11:27:30:INFO] [0315/112730.230306:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestSuccessIfPinMatches (63 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestBypass\n[11:27:30:INFO] [ OK ] PkpTest.TestBypass (9 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualTrue\n[11:27:30:INFO] [0315/112730.276026:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN\n[11:27:30:INFO] [0315/112730.278565:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102)\n[11:27:30:INFO] [0315/112730.284989:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualTrue (42 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualFalse\n[11:27:30:INFO] [0315/112730.355789:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualFalse (69 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestSoonExpiringPin\n[11:27:30:INFO] [0315/112730.392910:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN\n[11:27:30:INFO] [0315/112730.395277:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102)\n[11:27:30:INFO] [0315/112730.401713:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestSoonExpiringPin (45 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestRecentlyExpiredPin\n[11:27:30:INFO] [0315/112730.460551:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestRecentlyExpiredPin (57 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestPinsAreNotPersisted\n[11:27:30:INFO] [0315/112730.495559:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN\n[11:27:30:INFO] [0315/112730.498333:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102)\n[11:27:30:INFO] [0315/112730.504747:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [0315/112730.551614:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestPinsAreNotPersisted (90 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestHashLengthError\n[11:27:30:INFO] [ OK ] PkpTest.TestHashLengthError (9 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestPkpOverrideNonMatchingToMatching\n[11:27:30:INFO] [0315/112730.628498:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestPkpOverrideNonMatchingToMatching (64 ms)\n[11:27:30:INFO] [ RUN ] PkpTest.TestPkpOverrideMatchingToNonMatching\n[11:27:30:INFO] [0315/112730.674656:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN\n[11:27:30:INFO] [0315/112730.675689:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_QUIC_PROTOCOL_ERROR (-356)\n[11:27:30:INFO] [0315/112730.683530:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:27:30:INFO] [ OK ] PkpTest.TestPkpOverrideMatchingToNonMatching (53 ms)\n[11:27:30:INFO] [----------] 12 tests from PkpTest (627 ms total)\n[11:27:30:INFO] \n[11:27:30:INFO] [----------] 1 test from PrefsTest\n[11:27:30:INFO] [ RUN ] PrefsTest.HttpSeverProperties\n[11:27:30:INFO] 2019-03-15 11:27:30.748 cronet_test[22623:1832005] Waiting for file /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Library/Caches/cronet/prefs/local_prefs.json.\n[11:27:30:INFO] 2019-03-15 11:27:30.748 cronet_test[22623:1832005] Time left: 80 seconds\n[11:27:35:INFO] 2019-03-15 11:27:35.749 cronet_test[22623:1832005] Time left: 75 seconds\n[11:27:40:INFO] 2019-03-15 11:27:40.752 cronet_test[22623:1832005] Time left: 70 seconds\n[11:27:45:INFO] 2019-03-15 11:27:45.754 cronet_test[22623:1832005] Time left: 65 seconds\n[11:27:50:INFO] 2019-03-15 11:27:50.756 cronet_test[22623:1832005] Time left: 60 seconds\n[11:27:55:INFO] 2019-03-15 11:27:55.759 cronet_test[22623:1832005] Time left: 55 seconds\n[11:28:00:INFO] 2019-03-15 11:28:00.761 cronet_test[22623:1832005] Time left: 50 seconds\n[11:28:05:INFO] 2019-03-15 11:28:05.763 cronet_test[22623:1832005] Time left: 45 seconds\n[11:28:10:INFO] 2019-03-15 11:28:10.766 cronet_test[22623:1832005] Time left: 40 seconds\n[11:28:15:INFO] 2019-03-15 11:28:15.768 cronet_test[22623:1832005] Time left: 35 seconds\n[11:28:20:INFO] 2019-03-15 11:28:20.770 cronet_test[22623:1832005] Time left: 30 seconds\n[11:28:25:INFO] 2019-03-15 11:28:25.772 cronet_test[22623:1832005] Time left: 25 seconds\n[11:28:30:INFO] 2019-03-15 11:28:30.775 cronet_test[22623:1832005] Time left: 20 seconds\n[11:28:35:INFO] 2019-03-15 11:28:35.776 cronet_test[22623:1832005] Time left: 15 seconds\n[11:28:40:INFO] 2019-03-15 11:28:40.779 cronet_test[22623:1832005] File /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/382BB806-2118-4152-B414-0DC95773FFD6/data/Containers/Data/Application/2D589E29-5B81-4805-A393-EAAA8EB24C11/Library/Caches/cronet/prefs/local_prefs.json exists.\n[11:28:40:INFO] [0315/112840.787831:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:28:40:INFO] [ OK ] PrefsTest.HttpSeverProperties (70103 ms)\n[11:28:40:INFO] [----------] 1 test from PrefsTest (70105 ms total)\n[11:28:40:INFO] \n[11:28:40:INFO] [----------] 3 tests from QuicTest\n[11:28:40:INFO] [ RUN ] QuicTest.InvalidQuicHost\n[11:28:40:INFO] [0315/112840.798488:ERROR:Cronet.mm(218)] Invalid QUIC hint host: https://test.example.com/\n[11:28:40:INFO] [ OK ] QuicTest.InvalidQuicHost (8 ms)\n[11:28:40:INFO] [ RUN ] QuicTest.ValidQuicHost\n[11:28:40:INFO] [ OK ] QuicTest.ValidQuicHost (8 ms)\n[11:28:40:INFO] [ RUN ] QuicTest.RequestWithSocketOptimizationEnabled\n[11:28:40:INFO] [0315/112840.869420:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:28:40:INFO] [ OK ] QuicTest.RequestWithSocketOptimizationEnabled (59 ms)\n[11:28:40:INFO] [----------] 3 tests from QuicTest (81 ms total)\n[11:28:40:INFO] \n[11:28:40:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest\n[11:28:40:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0\n[11:28:40:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 (53 ms)\n[11:28:40:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1\n[11:28:40:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 (53 ms)\n[11:28:40:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 (60 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 (62 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 (54 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 (50 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 (55 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 (60 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 (60 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 (55 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 (54 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 (58 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 (60 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 (67 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 (66 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1 (58 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 (58 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1\n[11:28:41:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 (62 ms)\n[11:28:41:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 (60 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 (53 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0\n[11:28:42:INFO] [0315/112842.077610:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 (14 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1\n[11:28:42:INFO] [0315/112842.091594:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 (12 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0 (64 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1 (59 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0\n[11:28:42:INFO] [0315/112842.231715:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 (11 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1\n[11:28:42:INFO] [0315/112842.244652:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 (11 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 (54 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 (49 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0\n[11:28:42:INFO] [0315/112842.416923:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed.\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 (65 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1\n[11:28:42:INFO] [0315/112842.471040:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed.\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 (52 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 (14 ms)\n[11:28:42:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1\n[11:28:42:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 (14 ms)\n[11:28:42:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest (1635 ms total)\n[11:28:42:INFO] \n[11:28:42:INFO] [----------] 5 tests from Loops/PerfTest\n[11:28:42:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0\n[11:28:42:INFO] [22623:771:0315/112842.516982:42760053738003:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0\tHTTP2: 0\tAKD4: 0\tCronet: 0\n[11:28:42:INFO] [22623:771:0315/112842.517196:42760053937249:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration\n[11:28:43:INFO] [22623:771:0315/112843.450926:42760987743860:INFO:cronet_performance_test.mm(253)] Elapsed Total:914.548ms\n[11:28:43:INFO] [0315/112843.457075:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:28:43:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0 (951 ms)\n[11:28:43:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1\n[11:28:43:INFO] [22623:771:0315/112843.473852:42761010645229:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0\tHTTP2: 0\tAKD4: 0\tCronet: 1\n[11:28:43:INFO] [22623:771:0315/112843.474015:42761010798928:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration\n[11:28:44:INFO] [22623:771:0315/112844.051365:42761588198009:INFO:cronet_performance_test.mm(253)] Elapsed Total:559.649ms\n[11:28:44:INFO] [0315/112844.055940:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:28:44:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1 (597 ms)\n[11:28:44:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2\n[11:28:44:INFO] [22623:771:0315/112844.070084:42761606930534:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0\tHTTP2: 1\tAKD4: 0\tCronet: 1\n[11:28:44:INFO] [22623:771:0315/112844.070272:42761607091563:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration\n[11:28:44:INFO] [22623:771:0315/112844.633216:42762170070235:INFO:cronet_performance_test.mm(253)] Elapsed Total:545.252ms\n[11:28:44:INFO] [0315/112844.637803:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:28:44:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2 (581 ms)\n[11:28:44:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3\n[11:28:44:INFO] [22623:771:0315/112844.652033:42762188887384:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1\tHTTP2: 0\tAKD4: 0\tCronet: 1\n[11:28:44:INFO] [22623:771:0315/112844.652188:42762189029914:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration\n[11:28:45:INFO] [22623:771:0315/112845.234572:42762771470148:INFO:cronet_performance_test.mm(253)] Elapsed Total:564.98ms\n[11:28:45:INFO] [0315/112845.239454:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:28:45:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3 (599 ms)\n[11:28:45:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4\n[11:28:45:INFO] [22623:771:0315/112845.257240:42762794141136:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1\tHTTP2: 0\tAKD4: 1\tCronet: 1\n[11:28:45:INFO] [22623:771:0315/112845.257449:42762794332255:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration\n[11:28:45:INFO] [22623:771:0315/112845.849493:42763386423567:INFO:cronet_performance_test.mm(253)] Elapsed Total:574.633ms\n[11:28:45:INFO] [0315/112845.854486:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread.\n[11:28:45:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4 (613 ms)\n[11:28:45:INFO] [22623:771:0315/112845.857551:42763394481642:INFO:cronet_performance_test.mm(71)] Performance Data:\n[11:28:45:INFO] [22623:771:0315/112845.857779:42763394704724:INFO:cronet_performance_test.mm(88)] Quic 0\tHttp2 0\tAKD4 0\tCronet 0: Mean: 0.091455s (1688.916552mbps)\tMax: 0.107349s with 0 fails out of 10 total requests.\n[11:28:45:INFO] [22623:771:0315/112845.857982:42763394905832:INFO:cronet_performance_test.mm(88)] Quic 0\tHttp2 0\tAKD4 0\tCronet 1: Mean: 0.055965s (2759.934918mbps)\tMax: 0.060701s with 0 fails out of 10 total requests.\n[11:28:45:INFO] [22623:771:0315/112845.858181:42763395111937:INFO:cronet_performance_test.mm(88)] Quic 0\tHttp2 1\tAKD4 0\tCronet 1: Mean: 0.054525s (2832.809816mbps)\tMax: 0.059261s with 0 fails out of 10 total requests.\n[11:28:45:INFO] [22623:771:0315/112845.858387:42763395310122:INFO:cronet_performance_test.mm(88)] Quic 1\tHttp2 0\tAKD4 0\tCronet 1: Mean: 0.056498s (2733.892148mbps)\tMax: 0.068893s with 0 fails out of 10 total requests.\n[11:28:45:INFO] [22623:771:0315/112845.858583:42763395496362:INFO:cronet_performance_test.mm(88)] Quic 1\tHttp2 0\tAKD4 1\tCronet 1: Mean: 0.057463s (2687.967997mbps)\tMax: 0.063765s with 0 fails out of 10 total requests.\n[11:28:45:INFO] [----------] 5 tests from Loops/PerfTest (3350 ms total)\n[11:28:45:INFO] \n[11:28:45:INFO] [----------] Global test environment tear-down\n[11:28:45:INFO] [==========] 166 tests from 14 test suites ran. (82094 ms total)\n[11:28:45:INFO] [ PASSED ] 166 tests.\n[11:28:45:INFO] \n[11:28:45:INFO] YOU HAVE 2 DISABLED TESTS\n[11:28:45:INFO] \n[11:28:56:INFO] Testing started on 'iPhone 5s'\n[11:28:56:INFO] 2019-03-15 11:26:59.799 xcodebuild[22524:1830683] IDETestOperationsObserverDebug: Writing diagnostic log for test session to:\n[11:28:56:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-bpvozwrbeooirwgzqvbonurvyomy/Logs/Test/Test-Transient Testing-2019.03.15_11-26-59--0700.xcresult/1_Test/Diagnostics/cronet_test-62F92F7D-E311-484F-8EFF-E91789071154/cronet_test-40418BE4-9E23-4443-8D80-D89C7F3239D7/Session-cronet_test-2019-03-15_112659-8vZdvz.log\n[11:28:56:INFO] 2019-03-15 11:26:59.799 xcodebuild[22524:1830673] [MT] IDETestOperationsObserverDebug: (58480BD6-D205-4A61-8CD6-CAC288D91844) Beginning test session cronet_test-58480BD6-D205-4A61-8CD6-CAC288D91844 at 2019-03-15 11:26:59.799 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fd92a27a5c0> {\n[11:28:56:INFO] \t\tSimDevice: iPhone 5s (382BB806-2118-4152-B414-0DC95773FFD6, iOS 9.3, Shutdown)\n[11:28:56:INFO] } (9.3 (13E233))\n[11:28:56:INFO] 2019-03-15 11:28:55.530 xcodebuild[22524:1830673] [MT] IDETestOperationsObserverDebug: 116.194 elapsed -- Testing started completed.\n[11:28:56:INFO] 2019-03-15 11:28:55.530 xcodebuild[22524:1830673] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start\n[11:28:56:INFO] 2019-03-15 11:28:55.530 xcodebuild[22524:1830673] [MT] IDETestOperationsObserverDebug: 116.194 sec, +116.194 sec -- end\n[11:28:56:INFO] \n[11:28:56:INFO] Testing failed:\n[11:28:56:INFO] \tcronet_test.app (22623) encountered an error (Early unexpected exit, operation never finished bootstrapping - no restart will be attempted. (Underlying error: Test runner exited before starting test execution.))\n[11:28:56:DEBUG] Finished print_process_output.\n[11:28:56:INFO] Waiting for test process to terminate.\n[11:28:56:INFO] Test process terminated.\n[11:28:56:DEBUG] Setting sigterm handler.\n[11:28:56:DEBUG] Stdout flushed after test process.\n[11:28:56:DEBUG] Processing test results.\n[11:28:56:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 65\n\n[11:28:56:DEBUG] Extracting test data.\n[11:28:56:DEBUG] Retrieving crash reports.\n[11:28:56:DEBUG] Retrieving derived data.\n[11:28:56:DEBUG] Making desktop screenshots.\n[11:28:57:DEBUG] Killing simulators.\n[11:29:02:DEBUG] Wiping simulator.\nDevice wiped.\n[11:29:04:DEBUG] End of tear_down.\n", "outputs_ref": { "isolated": "c24c43eb411dafd912cfc118fb703eb487b13718", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "439b606487180711", "server_versions": [ "4201-b04f7f8" ], "started_ts": "2019-03-15T18:26:29.910964", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:ios-simulator-cronet", "buildnumber:69659", "data:340314046921a3dd21edf3742e77e4402c55373a", "device_type:iPhone 5s", "ios_version:9.3", "master:chromium.fyi", "name:cronet_test", "os:Mac-10.13.6", "platform:simulator", "pool:Chrome", "priority:200", "service_account:ios-isolated-tester@chops-service-accounts.iam.gserviceaccount.com", "slavename:build212-m9", "spec_name:chromium.ci:ios-simulator-cronet", "stepname:cronet_test (iPhone 5s iOS 9.3) on Mac-10.13.6", "swarming.pool.template:none", "swarming.pool.version:87d6b23020d6110f27e719c38e07e7635a2cd673", "test:cronet_test", "user:None" ], "task_id": "439b606487180710", "try_number": "1" } ] }