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/tmplIC7P2.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/6KbW1L3 --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/tmpMo3YvVmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpn9rjFA.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/tmpxVFyoe.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/tmplIC7P2.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/6KbW1L3', '--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/tmpMo3YvVmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpn9rjFA.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/tmpxVFyoe.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('cronet_test (iPhone X iOS 12.1) 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.7FNNhJz6CM/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: 53461 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/8918667360491294064 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/it307O00/luci_context.527260701 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.NKJJGlflGM/Listeners SWARMING_BOT_ID: build212-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43a874a2b3efe611 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-18 00:17:15,581 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/6KbW1L3' 2019-03-18 00:17:15,581 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/6KbW1L3' already exists! 2019-03-18 00:17:15,581 - root: [WARNING] task_output_dir existing content: [] 2019-03-18 00:17:15,581 - 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/tmpxVFyoe.json -output-dir /b/s/w/ir/k/recipe_cleanup/6KbW1L3 -task-summary-json /b/s/w/ir/tmp/t/tmpn9rjFA.json [D2019-03-18T00:17:15.595940-07:00 7972 0 auth.go:1265] Minting a new token {"key":"luci_ctx/31e255d9bae551d009b3eeaba1d73e6fb9bcdbd6406c6d4791c9aa9fe839bc38", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T00:17:15.596010-07:00 7972 0 luci_ctx.go:138] POST http://127.0.0.1:53450/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/31e255d9bae551d009b3eeaba1d73e6fb9bcdbd6406c6d4791c9aa9fe839bc38", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T00:17:15.597427-07:00 7972 0 auth.go:1222] Token expires in 35m18.40259s {"key":"luci_ctx/31e255d9bae551d009b3eeaba1d73e6fb9bcdbd6406c6d4791c9aa9fe839bc38", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 43a877c82bb3c110: exit 0 [I 2019-03-18 00:14:01] About to install Xcode 10b61 in Xcode.app for ios [12:14:02:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer Device wiped. [12:14:10:DEBUG] Setting sigterm handler. [12:14:11:INFO] User defaults from command line: [12:14:11:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/A97C0243-2466-42D2-8AD8-82D3A709BBFA [12:14:11:INFO] [12:14:30:INFO] objc[11624]: Class CRBProtocolObservers is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Bundle/Application/0AF5F13B-E3C7-48A4-A0C0-056AC0C6B857/cronet_test.app/Frameworks/Cronet.framework/Cronet (0x1142dcb10) and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Bundle/Application/0AF5F13B-E3C7-48A4-A0C0-056AC0C6B857/cronet_test.app/cronet_test (0x10ea32658). One of the two will be used. Which one is undefined. [12:14:30:INFO] objc[11624]: Class CRBWeakNSProtocolSentinel is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Bundle/Application/0AF5F13B-E3C7-48A4-A0C0-056AC0C6B857/cronet_test.app/Frameworks/Cronet.framework/Cronet (0x1142dcb60) and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Bundle/Application/0AF5F13B-E3C7-48A4-A0C0-056AC0C6B857/cronet_test.app/cronet_test (0x10ea326a8). One of the two will be used. Which one is undefined. [12:14:30:INFO] [==========] Running 166 tests from 14 test suites. [12:14:30:INFO] [----------] Global test environment set-up. [12:14:30:INFO] [----------] 4 tests from BufferTest [12:14:30:INFO] [ RUN ] BufferTest.TestInitWithAlloc [12:14:30:INFO] [ OK ] BufferTest.TestInitWithAlloc (8 ms) [12:14:30:INFO] [ RUN ] BufferTest.TestInitWithHugeAllocFails [12:14:30:INFO] [ OK ] BufferTest.TestInitWithHugeAllocFails (1 ms) [12:14:30:INFO] [ RUN ] BufferTest.TestInitWithDataAndCallback [12:14:30:INFO] [ OK ] BufferTest.TestInitWithDataAndCallback (0 ms) [12:14:30:INFO] [ RUN ] BufferTest.TestCronetBufferAsync [12:14:30:INFO] [ OK ] BufferTest.TestCronetBufferAsync (2 ms) [12:14:30:INFO] [----------] 4 tests from BufferTest (16 ms total) [12:14:30:INFO] [12:14:30:INFO] [----------] 8 tests from EngineTest [12:14:30:INFO] [ RUN ] EngineTest.StartCronetEngine [12:14:30:INFO] [ OK ] EngineTest.StartCronetEngine (72 ms) [12:14:30:INFO] [ RUN ] EngineTest.CronetEngineDefaultUserAgent [12:14:30:INFO] [ OK ] EngineTest.CronetEngineDefaultUserAgent (1 ms) [12:14:30:INFO] [ RUN ] EngineTest.InitDifferentEngines [12:14:30:INFO] [ OK ] EngineTest.InitDifferentEngines (5 ms) [12:14:30:INFO] [ RUN ] EngineTest.StartResults [12:14:30:INFO] [0318/001430.737331:ERROR:engine.cc(135)] Disk cache path /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/tmp/.org.chromium.Chromium.eQbQis is already used, cache disabled. [12:14:30:INFO] [ OK ] EngineTest.StartResults (153 ms) [12:14:30:INFO] [ RUN ] EngineTest.InvalidPkpParams [12:14:30:INFO] [ OK ] EngineTest.InvalidPkpParams (0 ms) [12:14:30:INFO] [ RUN ] EngineTest.ValidPkpParams [12:14:30:INFO] [ OK ] EngineTest.ValidPkpParams (4 ms) [12:14:30:INFO] [ RUN ] EngineTest.SetMockCertVerifierForTesting [12:14:30:INFO] [ OK ] EngineTest.SetMockCertVerifierForTesting (2 ms) [12:14:30:INFO] [ RUN ] EngineTest.StartNetLogToFile [12:14:30:INFO] [0318/001430.962178:ERROR:cronet_url_request_context.cc(536)] Failed to open NetLog file for writing. [12:14:30:INFO] [ OK ] EngineTest.StartNetLogToFile (45 ms) [12:14:30:INFO] [----------] 8 tests from EngineTest (311 ms total) [12:14:30:INFO] [12:14:30:INFO] [----------] 2 tests from ExecutorsTest [12:14:30:INFO] [ RUN ] ExecutorsTest.TestCustom [12:14:30:INFO] [ OK ] ExecutorsTest.TestCustom (1 ms) [12:14:30:INFO] [ RUN ] ExecutorsTest.TestTestExecutor [12:14:30:INFO] [ OK ] ExecutorsTest.TestTestExecutor (1 ms) [12:14:30:INFO] [----------] 2 tests from ExecutorsTest (4 ms total) [12:14:30:INFO] [12:14:30:INFO] [----------] 57 tests from UrlRequestTest [12:14:30:INFO] [ RUN ] UrlRequestTest.UploadWithDirectExecutor [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithDirectExecutor (40 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.InitChecks/0 [12:14:31:INFO] [ OK ] UrlRequestTest.InitChecks/0 (4 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.InitChecks/1 [12:14:31:INFO] [ OK ] UrlRequestTest.InitChecks/1 (5 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.SimpleGet/0 [12:14:31:INFO] [ OK ] UrlRequestTest.SimpleGet/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.SimpleGet/1 [12:14:31:INFO] [ OK ] UrlRequestTest.SimpleGet/1 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadEmptyBodySync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadEmptyBodySync/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadEmptyBodySync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadEmptyBodySync/1 (10 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadSync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadSync/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadSync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadSync/1 (11 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.SSLCertificateError/0 [12:14:31:INFO] [0318/001431.139941:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:14:31:INFO] [11624:64543:0318/001431.140394:10086891519042:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:14:31:INFO] [ OK ] UrlRequestTest.SSLCertificateError/0 (64 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.SSLCertificateError/1 [12:14:31:INFO] [0318/001431.182036:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:14:31:INFO] [11624:59171:0318/001431.182212:10086933282772:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:14:31:INFO] [ OK ] UrlRequestTest.SSLCertificateError/1 (39 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesSync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesSync/0 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesSync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesSync/1 (9 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesAsync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesAsync/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadMultiplePiecesAsync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadMultiplePiecesAsync/1 (9 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadChangesDefaultMethod/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadChangesDefaultMethod/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadChangesDefaultMethod/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadChangesDefaultMethod/1 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithSetMethod/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithSetMethod/0 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithSetMethod/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithSetMethod/1 (9 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithBigRead/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithBigRead/0 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithBigRead/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithBigRead/1 (9 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRedirectSync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRedirectSync/0 (10 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRedirectSync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRedirectSync/1 (11 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRedirectAsync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRedirectAsync/0 (9 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRedirectAsync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRedirectAsync/1 (11 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithBadLength/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithBadLength/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithBadLength/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithBadLength/1 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithBadLengthBufferAligned/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithBadLengthBufferAligned/0 (74 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadWithBadLengthBufferAligned/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadWithBadLengthBufferAligned/1 (235 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadReadFailSync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadReadFailSync/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadReadFailSync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadReadFailSync/1 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadReadFailAsync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadReadFailAsync/0 (6 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadReadFailAsync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadReadFailAsync/1 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRewindFailSync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRewindFailSync/0 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRewindFailSync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRewindFailSync/1 (10 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRewindFailAsync/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRewindFailAsync/0 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadRewindFailAsync/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadRewindFailAsync/1 (10 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadChunked/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadChunked/0 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadChunked/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadChunked/1 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 (9 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadFailsWithoutInitializingStream/0 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadFailsWithoutInitializingStream/0 (6 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.UploadFailsWithoutInitializingStream/1 [12:14:31:INFO] [ OK ] UrlRequestTest.UploadFailsWithoutInitializingStream/1 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.SimpleRequest/0 [12:14:31:INFO] [ OK ] UrlRequestTest.SimpleRequest/0 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.SimpleRequest/1 [12:14:31:INFO] [ OK ] UrlRequestTest.SimpleRequest/1 (8 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.MultiRedirect/0 [12:14:31:INFO] [ OK ] UrlRequestTest.MultiRedirect/0 (14 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.MultiRedirect/1 [12:14:31:INFO] [ OK ] UrlRequestTest.MultiRedirect/1 (14 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.CancelRequest/0 [12:14:31:INFO] [ OK ] UrlRequestTest.CancelRequest/0 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.CancelRequest/1 [12:14:31:INFO] [ OK ] UrlRequestTest.CancelRequest/1 (11 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.FailedRequestHostNotFound/0 [12:14:31:INFO] [ OK ] UrlRequestTest.FailedRequestHostNotFound/0 (6 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.FailedRequestHostNotFound/1 [12:14:31:INFO] [ OK ] UrlRequestTest.FailedRequestHostNotFound/1 (7 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.TestCancel/0 [12:14:31:INFO] [ OK ] UrlRequestTest.TestCancel/0 (66 ms) [12:14:31:INFO] [ RUN ] UrlRequestTest.TestCancel/1 [12:14:32:INFO] [ OK ] UrlRequestTest.TestCancel/1 (73 ms) [12:14:32:INFO] [ RUN ] UrlRequestTest.PerfTest/0 [12:14:33:INFO] [11624:3587:0318/001433.342148:10089093167803:INFO:url_request_test.cc(993)] Total time 1298.5 ms [12:14:33:INFO] [11624:3587:0318/001433.342285:10089093291331:INFO:url_request_test.cc(994)] Single Iteration time 129.85 ms [12:14:33:INFO] [11624:3587:0318/001433.342364:10089093367820:INFO:url_request_test.cc(1001)] Average Throughput: 1189.52 mbps [12:14:33:INFO] [ OK ] UrlRequestTest.PerfTest/0 (1336 ms) [12:14:33:INFO] [ RUN ] UrlRequestTest.PerfTest/1 [12:14:35:INFO] [11624:3587:0318/001435.522177:10091273132984:INFO:url_request_test.cc(993)] Total time 2160.17 ms [12:14:35:INFO] [11624:3587:0318/001435.522301:10091273241534:INFO:url_request_test.cc(994)] Single Iteration time 216.017 ms [12:14:35:INFO] [11624:3587:0318/001435.522379:10091273318332:INFO:url_request_test.cc(1001)] Average Throughput: 715.034 mbps [12:14:35:INFO] [ OK ] UrlRequestTest.PerfTest/1 (2179 ms) [12:14:35:INFO] [ RUN ] UrlRequestTest.GetStatus/0 [12:14:35:INFO] [ OK ] UrlRequestTest.GetStatus/0 (8 ms) [12:14:35:INFO] [ RUN ] UrlRequestTest.GetStatus/1 [12:14:35:INFO] [ OK ] UrlRequestTest.GetStatus/1 (7 ms) [12:14:35:INFO] [----------] 57 tests from UrlRequestTest (4576 ms total) [12:14:35:INFO] [12:14:35:INFO] [----------] 5 tests from AcceptLangTest [12:14:35:INFO] [ RUN ] AcceptLangTest.Region [12:14:35:INFO] [ OK ] AcceptLangTest.Region (0 ms) [12:14:35:INFO] [ RUN ] AcceptLangTest.Lang [12:14:35:INFO] [ OK ] AcceptLangTest.Lang (0 ms) [12:14:35:INFO] [ RUN ] AcceptLangTest.Default [12:14:35:INFO] [ OK ] AcceptLangTest.Default (0 ms) [12:14:35:INFO] [ RUN ] AcceptLangTest.Append [12:14:35:INFO] [ OK ] AcceptLangTest.Append (0 ms) [12:14:35:INFO] [ RUN ] AcceptLangTest.NoDefaultAppend [12:14:35:INFO] 2019-03-18 00:14:35.550 cronet_test[11624:159986] en-GB,en-US,en [12:14:35:INFO] [ OK ] AcceptLangTest.NoDefaultAppend (0 ms) [12:14:35:INFO] [----------] 5 tests from AcceptLangTest (7 ms total) [12:14:35:INFO] [12:14:35:INFO] [----------] 21 tests from HttpTest [12:14:35:INFO] [ RUN ] HttpTest.CreateSslKeyLogFile [12:14:35:INFO] 2019-03-18 00:14:35.574 cronet_test[11624:160574] DiskCookieStorage changing policy from 2 to 0, cookie file: file:///Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Library/Cookies/org.chromium.gtest.cronet-test.binarycookies [12:14:35:INFO] [0318/001435.613379:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [0318/001435.617966:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.CreateSslKeyLogFile (68 ms) [12:14:35:INFO] [ RUN ] HttpTest.NSURLSessionReceivesData [12:14:35:INFO] [0318/001435.740500:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.NSURLSessionReceivesData (120 ms) [12:14:35:INFO] [ RUN ] HttpTest.GetGlobalMetricsDeltas [12:14:35:INFO] [0318/001435.826922:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.GetGlobalMetricsDeltas (85 ms) [12:14:35:INFO] [ RUN ] HttpTest.SdchDisabledByDefault [12:14:35:INFO] [0318/001435.846660:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.SdchDisabledByDefault (18 ms) [12:14:35:INFO] [ RUN ] HttpTest.AcceptEncodingSdchIsAllowed [12:14:35:INFO] [0318/001435.868020:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.AcceptEncodingSdchIsAllowed (20 ms) [12:14:35:INFO] [ RUN ] HttpTest.AcceptEncodingFooBarIsAllowed [12:14:35:INFO] [0318/001435.888373:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.AcceptEncodingFooBarIsAllowed (19 ms) [12:14:35:INFO] [ RUN ] HttpTest.NSURLSessionAcceptLanguage [12:14:35:INFO] [0318/001435.909521:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.NSURLSessionAcceptLanguage (20 ms) [12:14:35:INFO] [ RUN ] HttpTest.SetUserAgentIsExact [12:14:35:INFO] [0318/001435.930600:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.SetUserAgentIsExact (20 ms) [12:14:35:INFO] [ RUN ] HttpTest.SetCookie [12:14:35:INFO] [0318/001435.959613:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.SetCookie (28 ms) [12:14:35:INFO] [ RUN ] HttpTest.SetSystemCookie [12:14:35:INFO] [0318/001435.981884:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:35:INFO] [ OK ] HttpTest.SetSystemCookie (21 ms) [12:14:35:INFO] [ RUN ] HttpTest.SystemCookieWithNullCreationTime [12:14:36:INFO] [0318/001436.002634:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.SystemCookieWithNullCreationTime (19 ms) [12:14:36:INFO] [ RUN ] HttpTest.FilterOutRequest [12:14:36:INFO] [0318/001436.037530:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.FilterOutRequest (33 ms) [12:14:36:INFO] [ RUN ] HttpTest.FileSchemeNotSupported [12:14:36:INFO] [0318/001436.054608:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.FileSchemeNotSupported (16 ms) [12:14:36:INFO] [ RUN ] HttpTest.DataSchemeNotSupported [12:14:36:INFO] [0318/001436.072776:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.DataSchemeNotSupported (17 ms) [12:14:36:INFO] [ RUN ] HttpTest.BrotliAdvertisedTest [12:14:36:INFO] [0318/001436.087872:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [0318/001436.095066:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.BrotliAdvertisedTest (20 ms) [12:14:36:INFO] [ RUN ] HttpTest.BrotliNotAdvertisedTest [12:14:36:INFO] [0318/001436.111323:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [0318/001436.119745:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.BrotliNotAdvertisedTest (23 ms) [12:14:36:INFO] [ RUN ] HttpTest.BrotliHandleDecoding [12:14:36:INFO] [0318/001436.135589:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [0318/001436.144099:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.BrotliHandleDecoding (24 ms) [12:14:36:INFO] [ RUN ] HttpTest.PostRequest [12:14:36:INFO] [0318/001436.165695:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.PostRequest (20 ms) [12:14:36:INFO] [ RUN ] HttpTest.PostRequestWithBodyStream [12:14:36:INFO] [0318/001436.189142:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.PostRequestWithBodyStream (22 ms) [12:14:36:INFO] [ RUN ] HttpTest.PostRequestWithLargeBodyStream [12:14:36:INFO] [0318/001436.210712:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.PostRequestWithLargeBodyStream (20 ms) [12:14:36:INFO] [ RUN ] HttpTest.LegacyApi [12:14:36:INFO] [0318/001436.284313:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] HttpTest.LegacyApi (72 ms) [12:14:36:INFO] [----------] 21 tests from HttpTest (734 ms total) [12:14:36:INFO] [12:14:36:INFO] [----------] 8 tests from CronetEnabledMetricsTest [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsQuic [12:14:36:INFO] [0318/001436.359726:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsQuic (78 ms) [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsNotQuic [12:14:36:INFO] [0318/001436.386785:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsNotQuic (22 ms) [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.PlatformComparison [12:14:36:INFO] [0318/001436.418702:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.PlatformComparison (30 ms) [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.InvalidURL [12:14:36:INFO] [0318/001436.437173:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_NAME_NOT_RESOLVED (-105) [12:14:36:INFO] [0318/001436.441305:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.InvalidURL (21 ms) [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.CanceledRequest [12:14:36:INFO] [11624:3587:0318/001436.457518:10092208448196:WARNING:cronet_test_base.mm(119)] The request was canceled due to timeout. [12:14:36:INFO] [0318/001436.461504:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.CanceledRequest (19 ms) [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.ReusedConnection [12:14:36:INFO] [0318/001436.537746:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.ReusedConnection (76 ms) [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.SessionWithoutDelegate [12:14:36:INFO] [0318/001436.611215:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.SessionWithoutDelegate (72 ms) [12:14:36:INFO] [ RUN ] CronetEnabledMetricsTest.LegacyApi [12:14:36:INFO] [0318/001436.680185:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetEnabledMetricsTest.LegacyApi (68 ms) [12:14:36:INFO] [----------] 8 tests from CronetEnabledMetricsTest (397 ms total) [12:14:36:INFO] [12:14:36:INFO] [----------] 1 test from CronetDisabledMetricsTest [12:14:36:INFO] [ RUN ] CronetDisabledMetricsTest.MetricsDisabled [12:14:36:INFO] [0318/001436.749519:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] CronetDisabledMetricsTest.MetricsDisabled (68 ms) [12:14:36:INFO] [----------] 1 test from CronetDisabledMetricsTest (70 ms total) [12:14:36:INFO] [12:14:36:INFO] [----------] 7 tests from NetLogTest [12:14:36:INFO] [ RUN ] NetLogTest.OpenFile [12:14:36:INFO] [0318/001436.755430:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Documents/cronet_netlog.json [12:14:36:INFO] [0318/001436.769336:WARNING:cronet_environment.mm(186)] Started NetLog [12:14:36:INFO] [0318/001436.769547:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:14:36:INFO] [0318/001436.775598:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] NetLogTest.OpenFile (22 ms) [12:14:36:INFO] [ RUN ] NetLogTest.CreateFile [12:14:36:INFO] [0318/001436.779292:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Documents/C0091530-CBC7-4778-8BB8-3944EFA1C774-11624-0000092DD9A8016B_netlog.json [12:14:36:INFO] [0318/001436.793039:WARNING:cronet_environment.mm(186)] Started NetLog [12:14:36:INFO] [0318/001436.793236:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:14:36:INFO] [0318/001436.800867:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] NetLogTest.CreateFile (23 ms) [12:14:36:INFO] [ RUN ] NetLogTest.NonExistantDir [12:14:36:INFO] [0318/001436.804316:ERROR:cronet_environment.mm(158)] Can not start NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Documents/83695E8F-CDE2-4D3B-936D-0CBC6D893DB7-11624-0000092DDB281560/netlog.json: Undefined error: 0 [12:14:36:INFO] [0318/001436.806042:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] NetLogTest.NonExistantDir (4 ms) [12:14:36:INFO] [ RUN ] NetLogTest.ExistantDir [12:14:36:INFO] [0318/001436.810399:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Documents/B047987A-BB96-4E9A-A75D-18CE86C06A96-11624-0000092DDB7D6A8D/netlog.json [12:14:36:INFO] [0318/001436.824816:WARNING:cronet_environment.mm(186)] Started NetLog [12:14:36:INFO] [0318/001436.825671:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:14:36:INFO] [0318/001436.833597:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] NetLogTest.ExistantDir (26 ms) [12:14:36:INFO] [ RUN ] NetLogTest.EmptyFilename [12:14:36:INFO] [0318/001436.838532:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] NetLogTest.EmptyFilename (4 ms) [12:14:36:INFO] [ RUN ] NetLogTest.AbsoluteFilename [12:14:36:INFO] [0318/001436.844091:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] NetLogTest.AbsoluteFilename (4 ms) [12:14:36:INFO] [ RUN ] NetLogTest.ExperimentalOptions [12:14:36:INFO] [0318/001436.849221:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [0318/001436.851850:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Documents/cronet_netlog.json [12:14:36:INFO] [0318/001436.866016:WARNING:cronet_environment.mm(186)] Started NetLog [12:14:36:INFO] [0318/001436.866196:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:14:36:INFO] [0318/001436.872981:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] NetLogTest.ExperimentalOptions (28 ms) [12:14:36:INFO] [----------] 7 tests from NetLogTest (121 ms total) [12:14:36:INFO] [12:14:36:INFO] [----------] 12 tests from PkpTest [12:14:36:INFO] [ RUN ] PkpTest.TestSuccessIfPinSetForDifferentHost [12:14:36:INFO] [0318/001436.943523:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:36:INFO] [ OK ] PkpTest.TestSuccessIfPinSetForDifferentHost (71 ms) [12:14:36:INFO] [ RUN ] PkpTest.TestErrorIfPinDoesNotMatch [12:14:36:INFO] [0318/001436.979885:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:14:36:INFO] [0318/001436.982012:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:14:37:INFO] [0318/001436.999482:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestErrorIfPinDoesNotMatch (54 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestSuccessIfPinMatches [12:14:37:INFO] [0318/001437.073011:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestSuccessIfPinMatches (72 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestBypass [12:14:37:INFO] [ OK ] PkpTest.TestBypass (10 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualTrue [12:14:37:INFO] [0318/001437.118405:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:14:37:INFO] [0318/001437.120548:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:14:37:INFO] [0318/001437.135721:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualTrue (50 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualFalse [12:14:37:INFO] [0318/001437.204667:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualFalse (67 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestSoonExpiringPin [12:14:37:INFO] [0318/001437.239130:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:14:37:INFO] [0318/001437.241182:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:14:37:INFO] [0318/001437.257266:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestSoonExpiringPin (51 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestRecentlyExpiredPin [12:14:37:INFO] [0318/001437.330377:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestRecentlyExpiredPin (72 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestPinsAreNotPersisted [12:14:37:INFO] [0318/001437.364626:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:14:37:INFO] [0318/001437.366807:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:14:37:INFO] [0318/001437.381873:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [0318/001437.439535:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestPinsAreNotPersisted (107 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestHashLengthError [12:14:37:INFO] [ OK ] PkpTest.TestHashLengthError (9 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestPkpOverrideNonMatchingToMatching [12:14:37:INFO] [0318/001437.524493:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestPkpOverrideNonMatchingToMatching (74 ms) [12:14:37:INFO] [ RUN ] PkpTest.TestPkpOverrideMatchingToNonMatching [12:14:37:INFO] [0318/001437.562105:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:14:37:INFO] [0318/001437.564269:ERROR:crn_http_protocol_handler.mm(845)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:14:37:INFO] [0318/001437.580232:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:14:37:INFO] [ OK ] PkpTest.TestPkpOverrideMatchingToNonMatching (54 ms) [12:14:37:INFO] [----------] 12 tests from PkpTest (708 ms total) [12:14:37:INFO] [12:14:37:INFO] [----------] 1 test from PrefsTest [12:14:37:INFO] [ RUN ] PrefsTest.HttpSeverProperties [12:14:37:INFO] 2019-03-18 00:14:37.635 cronet_test[11624:159986] Waiting for file /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Library/Caches/cronet/prefs/local_prefs.json. [12:14:37:INFO] 2019-03-18 00:14:37.635 cronet_test[11624:159986] Time left: 80 seconds [12:14:42:INFO] 2019-03-18 00:14:42.636 cronet_test[11624:159986] Time left: 75 seconds [12:14:47:INFO] 2019-03-18 00:14:47.636 cronet_test[11624:159986] Time left: 70 seconds [12:14:52:INFO] 2019-03-18 00:14:52.637 cronet_test[11624:159986] Time left: 65 seconds [12:14:57:INFO] 2019-03-18 00:14:57.639 cronet_test[11624:159986] Time left: 60 seconds [12:15:02:INFO] 2019-03-18 00:15:02.639 cronet_test[11624:159986] Time left: 55 seconds [12:15:07:INFO] 2019-03-18 00:15:07.640 cronet_test[11624:159986] Time left: 50 seconds [12:15:12:INFO] 2019-03-18 00:15:12.640 cronet_test[11624:159986] Time left: 45 seconds [12:15:17:INFO] 2019-03-18 00:15:17.642 cronet_test[11624:159986] Time left: 40 seconds [12:15:22:INFO] 2019-03-18 00:15:22.644 cronet_test[11624:159986] Time left: 35 seconds [12:15:27:INFO] 2019-03-18 00:15:27.645 cronet_test[11624:159986] Time left: 30 seconds [12:15:32:INFO] 2019-03-18 00:15:32.648 cronet_test[11624:159986] Time left: 25 seconds [12:15:37:INFO] 2019-03-18 00:15:37.650 cronet_test[11624:159986] Time left: 20 seconds [12:15:42:INFO] 2019-03-18 00:15:42.652 cronet_test[11624:159986] Time left: 15 seconds [12:15:47:INFO] 2019-03-18 00:15:47.655 cronet_test[11624:159986] File /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/B8458021-5B0F-4D55-9E83-3C5C644A2687/data/Containers/Data/Application/C2002C51-54D0-4FCF-8992-1DAC175D716E/Library/Caches/cronet/prefs/local_prefs.json exists. [12:15:47:INFO] [0318/001547.660687:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:15:47:INFO] [ OK ] PrefsTest.HttpSeverProperties (70079 ms) [12:15:47:INFO] [----------] 1 test from PrefsTest (70081 ms total) [12:15:47:INFO] [12:15:47:INFO] [----------] 3 tests from QuicTest [12:15:47:INFO] [ RUN ] QuicTest.InvalidQuicHost [12:15:47:INFO] [0318/001547.669001:ERROR:Cronet.mm(218)] Invalid QUIC hint host: https://test.example.com/ [12:15:47:INFO] [ OK ] QuicTest.InvalidQuicHost (6 ms) [12:15:47:INFO] [ RUN ] QuicTest.ValidQuicHost [12:15:47:INFO] [ OK ] QuicTest.ValidQuicHost (6 ms) [12:15:47:INFO] [ RUN ] QuicTest.RequestWithSocketOptimizationEnabled [12:15:47:INFO] [0318/001547.734086:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:15:47:INFO] [ OK ] QuicTest.RequestWithSocketOptimizationEnabled (56 ms) [12:15:47:INFO] [----------] 3 tests from QuicTest (73 ms total) [12:15:47:INFO] [12:15:47:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest [12:15:47:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 [12:15:47:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 (39 ms) [12:15:47:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 [12:15:47:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 (39 ms) [12:15:47:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 [12:15:47:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 (38 ms) [12:15:47:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 [12:15:47:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 (38 ms) [12:15:47:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 [12:15:47:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 (37 ms) [12:15:47:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 [12:15:47:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 (37 ms) [12:15:47:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 (39 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 [12:15:48:INFO] [0318/001548.526157:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 (9 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 [12:15:48:INFO] [0318/001548.536107:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 (9 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1 (38 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 [12:15:48:INFO] [0318/001548.625265:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 (9 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 [12:15:48:INFO] [0318/001548.635347:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 (9 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 [12:15:48:INFO] [0318/001548.750262:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed. [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 [12:15:48:INFO] [0318/001548.789008:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed. [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 (37 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 (9 ms) [12:15:48:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 [12:15:48:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 (9 ms) [12:15:48:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest (1078 ms total) [12:15:48:INFO] [12:15:48:INFO] [----------] 5 tests from Loops/PerfTest [12:15:48:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0 [12:15:48:INFO] [11624:3587:0318/001548.822045:10164570836890:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 0 AKD4: 0 Cronet: 0 [12:15:48:INFO] [11624:3587:0318/001548.822208:10164570948741:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:15:49:INFO] [11624:3587:0318/001549.429768:10165178503485:INFO:cronet_performance_test.mm(253)] Elapsed Total:595.53ms [12:15:49:INFO] [0318/001549.433389:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:15:49:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0 (620 ms) [12:15:49:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1 [12:15:49:INFO] [11624:3587:0318/001549.444427:10165193165996:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 0 AKD4: 0 Cronet: 1 [12:15:49:INFO] [11624:3587:0318/001549.444546:10165193267705:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:15:49:INFO] [11624:3587:0318/001549.978504:10165727267825:INFO:cronet_performance_test.mm(253)] Elapsed Total:521.828ms [12:15:49:INFO] [0318/001549.981930:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:15:49:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1 (547 ms) [12:15:49:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2 [12:15:49:INFO] [11624:3587:0318/001549.992793:10165741508865:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 1 AKD4: 0 Cronet: 1 [12:15:49:INFO] [11624:3587:0318/001549.992889:10165741593767:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:15:50:INFO] [11624:3587:0318/001550.521250:10166269979799:INFO:cronet_performance_test.mm(253)] Elapsed Total:516.202ms [12:15:50:INFO] [0318/001550.524838:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:15:50:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2 (541 ms) [12:15:50:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3 [12:15:50:INFO] [11624:3587:0318/001550.535779:10166284478524:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1 HTTP2: 0 AKD4: 0 Cronet: 1 [12:15:50:INFO] [11624:3587:0318/001550.535875:10166284555288:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:15:51:INFO] [11624:3587:0318/001551.067092:10166815801803:INFO:cronet_performance_test.mm(253)] Elapsed Total:519.085ms [12:15:51:INFO] [0318/001551.070540:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:15:51:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3 (544 ms) [12:15:51:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4 [12:15:51:INFO] [11624:3587:0318/001551.081510:10166830200006:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1 HTTP2: 0 AKD4: 1 Cronet: 1 [12:15:51:INFO] [11624:3587:0318/001551.081618:10166830284770:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:15:51:INFO] [11624:3587:0318/001551.609498:10167358187452:INFO:cronet_performance_test.mm(253)] Elapsed Total:515.732ms [12:15:51:INFO] [0318/001551.613038:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:15:51:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4 (541 ms) [12:15:51:INFO] [11624:3587:0318/001551.615471:10167364148995:INFO:cronet_performance_test.mm(71)] Performance Data: [12:15:51:INFO] [11624:3587:0318/001551.615650:10167364303171:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 0 AKD4 0 Cronet 0: Mean: 0.059553s (2593.647213mbps) Max: 0.062683s with 0 fails out of 10 total requests. [12:15:51:INFO] [11624:3587:0318/001551.615731:10167364377786:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 0 AKD4 0 Cronet 1: Mean: 0.052183s (2959.970161mbps) Max: 0.055949s with 0 fails out of 10 total requests. [12:15:51:INFO] [11624:3587:0318/001551.615803:10167364459469:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 1 AKD4 0 Cronet 1: Mean: 0.051620s (2992.230175mbps) Max: 0.054997s with 0 fails out of 10 total requests. [12:15:51:INFO] [11624:3587:0318/001551.615900:10167364555154:INFO:cronet_performance_test.mm(88)] Quic 1 Http2 0 AKD4 0 Cronet 1: Mean: 0.051908s (2975.611561mbps) Max: 0.054944s with 0 fails out of 10 total requests. [12:15:51:INFO] [11624:3587:0318/001551.615989:10167364641102:INFO:cronet_performance_test.mm(88)] Quic 1 Http2 0 AKD4 1 Cronet 1: Mean: 0.051573s (2994.957318mbps) Max: 0.055644s with 0 fails out of 10 total requests. [12:15:51:INFO] [----------] 5 tests from Loops/PerfTest (2801 ms total) [12:15:51:INFO] [12:15:51:INFO] [----------] Global test environment tear-down [12:15:51:INFO] [==========] 166 tests from 14 test suites ran. (80979 ms total) [12:15:51:INFO] [ PASSED ] 166 tests. [12:15:51:INFO] [12:15:51:INFO] YOU HAVE 2 DISABLED TESTS [12:15:51:INFO] [12:16:11:INFO] Testing started on 'iPhone X' [12:16:11:INFO] 2019-03-18 00:14:11.964 xcodebuild[11510:158901] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [12:16:11:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-dffbqwwujuqracbsouydzxmshoid/Logs/Test/Test-Transient Testing-2019.03.18_00-14-11--0700.xcresult/1_Test/Diagnostics/cronet_test-91FD71E6-E118-4922-A016-BF25EFA5B3EB/cronet_test-44F1D7B6-1F0F-455A-B609-2AA62524A0E8/Session-cronet_test-2019-03-18_001411-OhMLdQ.log [12:16:11:INFO] 2019-03-18 00:14:11.964 xcodebuild[11510:158883] [MT] IDETestOperationsObserverDebug: (6D035E55-B721-4D62-8A1B-9E077565D24C) Beginning test session cronet_test-6D035E55-B721-4D62-8A1B-9E077565D24C at 2019-03-18 00:14:11.964 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7f9a5e8ca3d0> { [12:16:11:INFO] SimDevice: iPhone X (B8458021-5B0F-4D55-9E83-3C5C644A2687, iOS 12.1, Shutdown) [12:16:11:INFO] } (12.1 (16B91)) [12:16:11:INFO] 2019-03-18 00:16:05.038 xcodebuild[11510:158883] [MT] IDETestOperationsObserverDebug: 113.149 elapsed -- Testing started completed. [12:16:11:INFO] 2019-03-18 00:16:05.038 xcodebuild[11510:158883] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [12:16:11:INFO] 2019-03-18 00:16:05.038 xcodebuild[11510:158883] [MT] IDETestOperationsObserverDebug: 113.149 sec, +113.149 sec -- end [12:16:11:DEBUG] Finished print_process_output. [12:16:11:INFO] Waiting for test process to terminate. [12:16:11:INFO] Test process terminated. [12:16:11:DEBUG] Setting sigterm handler. [12:16:11:DEBUG] Stdout flushed after test process. [12:16:11:DEBUG] Processing test results. [12:16:11:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 65 [12:16:11:DEBUG] Extracting test data. [12:16:11:DEBUG] Retrieving crash reports. [12:16:11:DEBUG] Retrieving derived data. [12:16:11:DEBUG] Making desktop screenshots. [12:16:11:DEBUG] Killing simulators. [12:16:16:DEBUG] Wiping simulator. Device wiped. [12:16:18:DEBUG] End of tear_down. 2019-03-18 00:17:17,561 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/6KbW1L3/43a877c82bb3c110'] 2019-03-18 00:17:17,561 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/6KbW1L3/43a877c82bb3c110/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/6KbW1L3/43a877c82bb3c110/output.json'] 2019-03-18 00:17:17,561 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/6KbW1L3' Found ['/b/s/w/ir/k/recipe_cleanup/6KbW1L3/43a877c82bb3c110'] 2019-03-18 00:17:17,561 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/6KbW1L3/43a877c82bb3c110/output.json'] 2019-03-18 00:17:17,562 - 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/tmpn9rjFA.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/6KbW1L3 -o /b/s/w/ir/tmp/t/tmplIC7P2.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/tmpn9rjFA.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/6KbW1L3', '-o', '/b/s/w/ir/tmp/t/tmplIC7P2.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/tmpn9rjFA.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/6KbW1L3', '-o', '/b/s/w/ir/tmp/t/tmplIC7P2.json'] returned exit code 0