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/tmpei0KNT.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/6ksAslM --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/tmpLVsxGsmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpt4eQ4W.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/tmpxvNyCq.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/tmpei0KNT.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/6ksAslM', '--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/tmpLVsxGsmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpt4eQ4W.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/tmpxvNyCq.json'] env: FrozenDict([]) env_prefixes: {'mapping': FrozenDict([('PATH', ('/b/s/w/ir/cache/swarming_client',))]), 'pathsep': ':'} env_suffixes: {'mapping': FrozenDict([]), 'pathsep': ':'} infra_step: False name_tokens: ['cronet_test (iPhone X iOS 12.1) on Mac-10.13.6'] ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) trigger_specs: [] full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.8CmDYpAkDK/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: 57600 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/8915225225387382992 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/ir/tmp/luci_context.460267849 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.43XDrAHnOu/Listeners SWARMING_BOT_ID: build212-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 446c1e4c438e8e11 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-04-25 00:08:31,146 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/6ksAslM' 2019-04-25 00:08:31,146 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/6ksAslM' already exists! 2019-04-25 00:08:31,146 - root: [WARNING] task_output_dir existing content: [] 2019-04-25 00:08:31,146 - 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/tmpxvNyCq.json -output-dir /b/s/w/ir/k/recipe_cleanup/6ksAslM -task-summary-json /b/s/w/ir/tmp/t/tmpt4eQ4W.json [D2019-04-25T00:08:31.160026-07:00 3418 0 auth.go:1265] Minting a new token {"key":"luci_ctx/a889b1d192442e932df7ef65a2e4fd6dc767347bd284a9aa152e36c1ccbabc4a", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T00:08:31.160095-07:00 3418 0 luci_ctx.go:138] POST http://127.0.0.1:57588/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/a889b1d192442e932df7ef65a2e4fd6dc767347bd284a9aa152e36c1ccbabc4a", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T00:08:31.161508-07:00 3418 0 auth.go:1222] Token expires in 17m38.838529s {"key":"luci_ctx/a889b1d192442e932df7ef65a2e4fd6dc767347bd284a9aa152e36c1ccbabc4a", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 446c21003b157d10: exit 0 [I 2019-04-25 00:04:48] About to install Xcode 10b61 in Xcode.app for ios [12:04:49:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer Device wiped. [12:04:57:DEBUG] Setting sigterm handler. [12:04:59:INFO] User defaults from command line: [12:04:59:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/2D06606C-0A95-480E-8EFF-87F40AA80F01 [12:04:59:INFO] [12:05:17:INFO] objc[23988]: Class CRBProtocolObservers is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Bundle/Application/86F53A2B-402A-4375-819D-B058CECA2D3F/cronet_test.app/Frameworks/Cronet.framework/Cronet (0x10bb4a980) and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Bundle/Application/86F53A2B-402A-4375-819D-B058CECA2D3F/cronet_test.app/cronet_test (0x105fa38f8). One of the two will be used. Which one is undefined. [12:05:17:INFO] objc[23988]: Class CRBWeakNSProtocolSentinel is implemented in both /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Bundle/Application/86F53A2B-402A-4375-819D-B058CECA2D3F/cronet_test.app/Frameworks/Cronet.framework/Cronet (0x10bb4a9d0) and /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Bundle/Application/86F53A2B-402A-4375-819D-B058CECA2D3F/cronet_test.app/cronet_test (0x105fa3948). One of the two will be used. Which one is undefined. [12:05:18:INFO] [==========] Running 296 tests from 17 test suites. [12:05:18:INFO] [----------] Global test environment set-up. [12:05:18:INFO] [----------] 4 tests from BufferTest [12:05:18:INFO] [ RUN ] BufferTest.TestInitWithAlloc [12:05:18:INFO] [ OK ] BufferTest.TestInitWithAlloc (28 ms) [12:05:18:INFO] [ RUN ] BufferTest.TestInitWithHugeAllocFails [12:05:18:INFO] [ OK ] BufferTest.TestInitWithHugeAllocFails (1 ms) [12:05:18:INFO] [ RUN ] BufferTest.TestInitWithDataAndCallback [12:05:18:INFO] [ OK ] BufferTest.TestInitWithDataAndCallback (1 ms) [12:05:18:INFO] [ RUN ] BufferTest.TestCronetBufferAsync [12:05:18:INFO] [ OK ] BufferTest.TestCronetBufferAsync (4 ms) [12:05:18:INFO] [----------] 4 tests from BufferTest (42 ms total) [12:05:18:INFO] [12:05:18:INFO] [----------] 8 tests from EngineTest [12:05:18:INFO] [ RUN ] EngineTest.StartCronetEngine [12:05:18:INFO] [ OK ] EngineTest.StartCronetEngine (98 ms) [12:05:18:INFO] [ RUN ] EngineTest.CronetEngineDefaultUserAgent [12:05:18:INFO] [ OK ] EngineTest.CronetEngineDefaultUserAgent (1 ms) [12:05:18:INFO] [ RUN ] EngineTest.InitDifferentEngines [12:05:18:INFO] [ OK ] EngineTest.InitDifferentEngines (6 ms) [12:05:18:INFO] [ RUN ] EngineTest.StartResults [12:05:18:INFO] [0425/000518.431531:ERROR:engine.cc(135)] Disk cache path /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/tmp/.org.chromium.Chromium.poNnLh is already used, cache disabled. [12:05:18:INFO] [ OK ] EngineTest.StartResults (207 ms) [12:05:18:INFO] [ RUN ] EngineTest.InvalidPkpParams [12:05:18:INFO] [ OK ] EngineTest.InvalidPkpParams (0 ms) [12:05:18:INFO] [ RUN ] EngineTest.ValidPkpParams [12:05:18:INFO] [ OK ] EngineTest.ValidPkpParams (6 ms) [12:05:18:INFO] [ RUN ] EngineTest.SetMockCertVerifierForTesting [12:05:18:INFO] [ OK ] EngineTest.SetMockCertVerifierForTesting (3 ms) [12:05:18:INFO] [ RUN ] EngineTest.StartNetLogToFile [12:05:18:INFO] [0425/000518.708989:ERROR:cronet_url_request_context.cc(536)] Failed to open NetLog file for writing. [12:05:18:INFO] [ OK ] EngineTest.StartNetLogToFile (59 ms) [12:05:18:INFO] [----------] 8 tests from EngineTest (392 ms total) [12:05:18:INFO] [12:05:18:INFO] [----------] 2 tests from ExecutorsTest [12:05:18:INFO] [ RUN ] ExecutorsTest.TestCustom [12:05:18:INFO] [ OK ] ExecutorsTest.TestCustom (0 ms) [12:05:18:INFO] [ RUN ] ExecutorsTest.TestTestExecutor [12:05:18:INFO] [ OK ] ExecutorsTest.TestTestExecutor (0 ms) [12:05:18:INFO] [----------] 2 tests from ExecutorsTest (4 ms total) [12:05:18:INFO] [12:05:18:INFO] [----------] 1 test from UrlRequestTestNoParam [12:05:18:INFO] [ RUN ] UrlRequestTestNoParam.RequestFinishedListenerWithoutExecutorReturnsError [12:05:18:INFO] [ OK ] UrlRequestTestNoParam.RequestFinishedListenerWithoutExecutorReturnsError (3 ms) [12:05:18:INFO] [----------] 1 test from UrlRequestTestNoParam (5 ms total) [12:05:18:INFO] [12:05:18:INFO] [----------] 5 tests from AcceptLangTest [12:05:18:INFO] [ RUN ] AcceptLangTest.Region [12:05:18:INFO] [ OK ] AcceptLangTest.Region (0 ms) [12:05:18:INFO] [ RUN ] AcceptLangTest.Lang [12:05:18:INFO] [ OK ] AcceptLangTest.Lang (0 ms) [12:05:18:INFO] [ RUN ] AcceptLangTest.Default [12:05:18:INFO] [ OK ] AcceptLangTest.Default (0 ms) [12:05:18:INFO] [ RUN ] AcceptLangTest.Append [12:05:18:INFO] [ OK ] AcceptLangTest.Append (0 ms) [12:05:18:INFO] [ RUN ] AcceptLangTest.NoDefaultAppend [12:05:18:INFO] 2019-04-25 00:05:18.727 cronet_test[23988:338421] en-GB,en-US,en [12:05:18:INFO] [ OK ] AcceptLangTest.NoDefaultAppend (1 ms) [12:05:18:INFO] [----------] 5 tests from AcceptLangTest (7 ms total) [12:05:18:INFO] [12:05:18:INFO] [----------] 21 tests from HttpTest [12:05:18:INFO] [ RUN ] HttpTest.CreateSslKeyLogFile [12:05:18:INFO] 2019-04-25 00:05:18.790 cronet_test[23988:338549] DiskCookieStorage changing policy from 2 to 0, cookie file: file:///Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Library/Cookies/org.chromium.gtest.cronet-test.binarycookies [12:05:18:INFO] [0425/000518.812906:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:18:INFO] [0425/000518.818639:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:18:INFO] [ OK ] HttpTest.CreateSslKeyLogFile (93 ms) [12:05:18:INFO] [ RUN ] HttpTest.NSURLSessionReceivesData [12:05:19:INFO] [0425/000519.026535:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.NSURLSessionReceivesData (211 ms) [12:05:19:INFO] [ RUN ] HttpTest.GetGlobalMetricsDeltas [12:05:19:INFO] [0425/000519.115962:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.GetGlobalMetricsDeltas (82 ms) [12:05:19:INFO] [ RUN ] HttpTest.SdchDisabledByDefault [12:05:19:INFO] [0425/000519.145248:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.SdchDisabledByDefault (28 ms) [12:05:19:INFO] [ RUN ] HttpTest.AcceptEncodingSdchIsAllowed [12:05:19:INFO] [0425/000519.166929:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.AcceptEncodingSdchIsAllowed (20 ms) [12:05:19:INFO] [ RUN ] HttpTest.AcceptEncodingFooBarIsAllowed [12:05:19:INFO] [0425/000519.188586:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.AcceptEncodingFooBarIsAllowed (20 ms) [12:05:19:INFO] [ RUN ] HttpTest.NSURLSessionAcceptLanguage [12:05:19:INFO] [0425/000519.209735:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.NSURLSessionAcceptLanguage (20 ms) [12:05:19:INFO] [ RUN ] HttpTest.SetUserAgentIsExact [12:05:19:INFO] [0425/000519.230756:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.SetUserAgentIsExact (20 ms) [12:05:19:INFO] [ RUN ] HttpTest.SetCookie [12:05:19:INFO] [0425/000519.260831:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.SetCookie (28 ms) [12:05:19:INFO] [ RUN ] HttpTest.SetSystemCookie [12:05:19:INFO] [0425/000519.282424:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.SetSystemCookie (20 ms) [12:05:19:INFO] [ RUN ] HttpTest.SystemCookieWithNullCreationTime [12:05:19:INFO] [0425/000519.304249:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.SystemCookieWithNullCreationTime (21 ms) [12:05:19:INFO] [ RUN ] HttpTest.FilterOutRequest [12:05:19:INFO] [0425/000519.338334:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.FilterOutRequest (33 ms) [12:05:19:INFO] [ RUN ] HttpTest.FileSchemeNotSupported [12:05:19:INFO] [0425/000519.357635:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.FileSchemeNotSupported (18 ms) [12:05:19:INFO] [ RUN ] HttpTest.DataSchemeNotSupported [12:05:19:INFO] [0425/000519.375758:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.DataSchemeNotSupported (16 ms) [12:05:19:INFO] [ RUN ] HttpTest.BrotliAdvertisedTest [12:05:19:INFO] [0425/000519.392125:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [0425/000519.400972:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.BrotliAdvertisedTest (37 ms) [12:05:19:INFO] [ RUN ] HttpTest.BrotliNotAdvertisedTest [12:05:19:INFO] [0425/000519.430608:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [0425/000519.439495:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.BrotliNotAdvertisedTest (23 ms) [12:05:19:INFO] [ RUN ] HttpTest.BrotliHandleDecoding [12:05:19:INFO] [0425/000519.455256:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [0425/000519.465061:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.BrotliHandleDecoding (25 ms) [12:05:19:INFO] [ RUN ] HttpTest.PostRequest [12:05:19:INFO] [0425/000519.486688:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.PostRequest (20 ms) [12:05:19:INFO] [ RUN ] HttpTest.PostRequestWithBodyStream [12:05:19:INFO] [0425/000519.510428:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.PostRequestWithBodyStream (22 ms) [12:05:19:INFO] [ RUN ] HttpTest.PostRequestWithLargeBodyStream [12:05:19:INFO] [0425/000519.533334:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.PostRequestWithLargeBodyStream (22 ms) [12:05:19:INFO] [ RUN ] HttpTest.LegacyApi [12:05:19:INFO] [0425/000519.599096:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] HttpTest.LegacyApi (65 ms) [12:05:19:INFO] [----------] 21 tests from HttpTest (873 ms total) [12:05:19:INFO] [12:05:19:INFO] [----------] 8 tests from CronetEnabledMetricsTest [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsQuic [12:05:19:INFO] [0425/000519.670667:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsQuic (71 ms) [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.ProtocolIsNotQuic [12:05:19:INFO] [0425/000519.693515:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] CronetEnabledMetricsTest.ProtocolIsNotQuic (21 ms) [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.PlatformComparison [12:05:19:INFO] [0425/000519.728815:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] CronetEnabledMetricsTest.PlatformComparison (34 ms) [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.InvalidURL [12:05:19:INFO] [0425/000519.747349:ERROR:crn_http_protocol_handler.mm(848)] HttpProtocolHandlerCore - Network error: net::ERR_NAME_NOT_RESOLVED (-105) [12:05:19:INFO] [0425/000519.751581:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] CronetEnabledMetricsTest.InvalidURL (21 ms) [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.CanceledRequest [12:05:19:INFO] [23988:4611:0425/000519.768071:18472531634377:WARNING:cronet_test_base.mm(119)] The request was canceled due to timeout. [12:05:19:INFO] [0425/000519.771944:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] CronetEnabledMetricsTest.CanceledRequest (20 ms) [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.ReusedConnection [12:05:19:INFO] [0425/000519.873444:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] CronetEnabledMetricsTest.ReusedConnection (100 ms) [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.SessionWithoutDelegate [12:05:19:INFO] [0425/000519.944795:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:19:INFO] [ OK ] CronetEnabledMetricsTest.SessionWithoutDelegate (70 ms) [12:05:19:INFO] [ RUN ] CronetEnabledMetricsTest.LegacyApi [12:05:20:INFO] [0425/000520.015079:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] CronetEnabledMetricsTest.LegacyApi (68 ms) [12:05:20:INFO] [----------] 8 tests from CronetEnabledMetricsTest (417 ms total) [12:05:20:INFO] [12:05:20:INFO] [----------] 1 test from CronetDisabledMetricsTest [12:05:20:INFO] [ RUN ] CronetDisabledMetricsTest.MetricsDisabled [12:05:20:INFO] [0425/000520.101044:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] CronetDisabledMetricsTest.MetricsDisabled (85 ms) [12:05:20:INFO] [----------] 1 test from CronetDisabledMetricsTest (89 ms total) [12:05:20:INFO] [12:05:20:INFO] [----------] 7 tests from NetLogTest [12:05:20:INFO] [ RUN ] NetLogTest.OpenFile [12:05:20:INFO] [0425/000520.109997:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Documents/cronet_netlog.json [12:05:20:INFO] [0425/000520.124326:WARNING:cronet_environment.mm(186)] Started NetLog [12:05:20:INFO] [0425/000520.124544:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:05:20:INFO] [0425/000520.131193:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] NetLogTest.OpenFile (24 ms) [12:05:20:INFO] [ RUN ] NetLogTest.CreateFile [12:05:20:INFO] [0425/000520.134905:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Documents/B5AECBD8-C486-4052-BFB3-EB1CB2659956-23988-000010CD0E875137_netlog.json [12:05:20:INFO] [0425/000520.155246:WARNING:cronet_environment.mm(186)] Started NetLog [12:05:20:INFO] [0425/000520.155442:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:05:20:INFO] [0425/000520.162052:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] NetLogTest.CreateFile (30 ms) [12:05:20:INFO] [ RUN ] NetLogTest.NonExistantDir [12:05:20:INFO] [0425/000520.165688:ERROR:cronet_environment.mm(158)] Can not start NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Documents/6C9DE972-52A8-4544-AAA9-90650037612A-23988-000010CD105EC8AF/netlog.json: Undefined error: 0 [12:05:20:INFO] [0425/000520.167334:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] NetLogTest.NonExistantDir (4 ms) [12:05:20:INFO] [ RUN ] NetLogTest.ExistantDir [12:05:20:INFO] [0425/000520.171224:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Documents/2F51AB76-31AD-4BCE-9C67-93B6387F4DFE-23988-000010CD10AF628E/netlog.json [12:05:20:INFO] [0425/000520.185012:WARNING:cronet_environment.mm(186)] Started NetLog [12:05:20:INFO] [0425/000520.185673:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:05:20:INFO] [0425/000520.192256:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] NetLogTest.ExistantDir (24 ms) [12:05:20:INFO] [ RUN ] NetLogTest.EmptyFilename [12:05:20:INFO] [0425/000520.198475:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] NetLogTest.EmptyFilename (5 ms) [12:05:20:INFO] [ RUN ] NetLogTest.AbsoluteFilename [12:05:20:INFO] [0425/000520.203820:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] NetLogTest.AbsoluteFilename (3 ms) [12:05:20:INFO] [ RUN ] NetLogTest.ExperimentalOptions [12:05:20:INFO] [0425/000520.209629:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [0425/000520.212685:WARNING:cronet_environment.mm(163)] Starting NetLog to /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Documents/cronet_netlog.json [12:05:20:INFO] [0425/000520.227376:WARNING:cronet_environment.mm(186)] Started NetLog [12:05:20:INFO] [0425/000520.227566:WARNING:cronet_environment.mm(202)] Stopped NetLog. [12:05:20:INFO] [0425/000520.233795:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] NetLogTest.ExperimentalOptions (28 ms) [12:05:20:INFO] [----------] 7 tests from NetLogTest (128 ms total) [12:05:20:INFO] [12:05:20:INFO] [----------] 12 tests from PkpTest [12:05:20:INFO] [ RUN ] PkpTest.TestSuccessIfPinSetForDifferentHost [12:05:20:INFO] [0425/000520.299207:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestSuccessIfPinSetForDifferentHost (65 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestErrorIfPinDoesNotMatch [12:05:20:INFO] [0425/000520.339637:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:05:20:INFO] [0425/000520.340439:ERROR:crn_http_protocol_handler.mm(848)] HttpProtocolHandlerCore - Network error: net::ERR_QUIC_PROTOCOL_ERROR (-356) [12:05:20:INFO] [0425/000520.352744:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestErrorIfPinDoesNotMatch (53 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestSuccessIfPinMatches [12:05:20:INFO] [0425/000520.421329:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestSuccessIfPinMatches (67 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestBypass [12:05:20:INFO] [ OK ] PkpTest.TestBypass (10 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualTrue [12:05:20:INFO] [0425/000520.467782:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:05:20:INFO] [0425/000520.469703:ERROR:crn_http_protocol_handler.mm(848)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:05:20:INFO] [0425/000520.478714:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualTrue (45 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestIncludeSubdomainsFlagEqualFalse [12:05:20:INFO] [0425/000520.543483:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestIncludeSubdomainsFlagEqualFalse (63 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestSoonExpiringPin [12:05:20:INFO] [0425/000520.578389:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:05:20:INFO] [0425/000520.580357:ERROR:crn_http_protocol_handler.mm(848)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:05:20:INFO] [0425/000520.590982:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestSoonExpiringPin (53 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestRecentlyExpiredPin [12:05:20:INFO] [0425/000520.666082:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestRecentlyExpiredPin (68 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestPinsAreNotPersisted [12:05:20:INFO] [0425/000520.702644:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:05:20:INFO] [0425/000520.704518:ERROR:crn_http_protocol_handler.mm(848)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:05:20:INFO] [0425/000520.714030:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [0425/000520.770448:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestPinsAreNotPersisted (104 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestHashLengthError [12:05:20:INFO] [ OK ] PkpTest.TestHashLengthError (10 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestPkpOverrideNonMatchingToMatching [12:05:20:INFO] [0425/000520.847280:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestPkpOverrideNonMatchingToMatching (64 ms) [12:05:20:INFO] [ RUN ] PkpTest.TestPkpOverrideMatchingToNonMatching [12:05:20:INFO] [0425/000520.883032:WARNING:proof_verifier_chromium.cc(501)] Failed to verify certificate chain: net::ERR_SSL_PINNED_KEY_NOT_IN_CERT_CHAIN [12:05:20:INFO] [0425/000520.884944:ERROR:crn_http_protocol_handler.mm(848)] HttpProtocolHandlerCore - Network error: net::ERR_CONNECTION_REFUSED (-102) [12:05:20:INFO] [0425/000520.894899:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:05:20:INFO] [ OK ] PkpTest.TestPkpOverrideMatchingToNonMatching (47 ms) [12:05:20:INFO] [----------] 12 tests from PkpTest (662 ms total) [12:05:20:INFO] [12:05:20:INFO] [----------] 1 test from PrefsTest [12:05:20:INFO] [ RUN ] PrefsTest.HttpSeverProperties [12:05:20:INFO] 2019-04-25 00:05:20.951 cronet_test[23988:338421] Waiting for file /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Library/Caches/cronet/prefs/local_prefs.json. [12:05:20:INFO] 2019-04-25 00:05:20.951 cronet_test[23988:338421] Time left: 80 seconds [12:05:25:INFO] 2019-04-25 00:05:25.952 cronet_test[23988:338421] Time left: 75 seconds [12:05:30:INFO] 2019-04-25 00:05:30.952 cronet_test[23988:338421] Time left: 70 seconds [12:05:35:INFO] 2019-04-25 00:05:35.953 cronet_test[23988:338421] Time left: 65 seconds [12:05:40:INFO] 2019-04-25 00:05:40.953 cronet_test[23988:338421] Time left: 60 seconds [12:05:45:INFO] 2019-04-25 00:05:45.954 cronet_test[23988:338421] Time left: 55 seconds [12:05:50:INFO] 2019-04-25 00:05:50.954 cronet_test[23988:338421] Time left: 50 seconds [12:05:55:INFO] 2019-04-25 00:05:55.955 cronet_test[23988:338421] Time left: 45 seconds [12:06:00:INFO] 2019-04-25 00:06:00.956 cronet_test[23988:338421] Time left: 40 seconds [12:06:05:INFO] 2019-04-25 00:06:05.959 cronet_test[23988:338421] Time left: 35 seconds [12:06:10:INFO] 2019-04-25 00:06:10.962 cronet_test[23988:338421] Time left: 30 seconds [12:06:15:INFO] 2019-04-25 00:06:15.963 cronet_test[23988:338421] Time left: 25 seconds [12:06:20:INFO] 2019-04-25 00:06:20.964 cronet_test[23988:338421] Time left: 20 seconds [12:06:25:INFO] 2019-04-25 00:06:25.966 cronet_test[23988:338421] Time left: 15 seconds [12:06:30:INFO] 2019-04-25 00:06:30.969 cronet_test[23988:338421] File /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/219CD6ED-0AA6-40D4-B86D-0139D5872524/data/Containers/Data/Application/5199FE0C-5409-43F6-AA77-8A3C7562C3BB/Library/Caches/cronet/prefs/local_prefs.json exists. [12:06:30:INFO] [0425/000630.974356:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:06:30:INFO] [ OK ] PrefsTest.HttpSeverProperties (70078 ms) [12:06:30:INFO] [----------] 1 test from PrefsTest (70079 ms total) [12:06:30:INFO] [12:06:30:INFO] [----------] 3 tests from QuicTest [12:06:30:INFO] [ RUN ] QuicTest.InvalidQuicHost [12:06:30:INFO] [0425/000630.981918:ERROR:Cronet.mm(218)] Invalid QUIC hint host: https://test.example.com/ [12:06:30:INFO] [ OK ] QuicTest.InvalidQuicHost (6 ms) [12:06:30:INFO] [ RUN ] QuicTest.ValidQuicHost [12:06:30:INFO] [ OK ] QuicTest.ValidQuicHost (6 ms) [12:06:30:INFO] [ RUN ] QuicTest.RequestWithSocketOptimizationEnabled [12:06:31:INFO] [0425/000631.037878:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:06:31:INFO] [ OK ] QuicTest.RequestWithSocketOptimizationEnabled (48 ms) [12:06:31:INFO] [----------] 3 tests from QuicTest (64 ms total) [12:06:31:INFO] [12:06:31:INFO] [----------] 62 tests from NoRequestFinishedListener/UrlRequestTest [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.InitChecks/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.InitChecks/0 (4 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.InitChecks/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.InitChecks/1 (4 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.SimpleGet/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.SimpleGet/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.SimpleGet/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.SimpleGet/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadEmptyBodySync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadEmptyBodySync/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadEmptyBodySync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadEmptyBodySync/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadSync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadSync/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadSync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadSync/1 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.SSLCertificateError/0 [12:06:31:INFO] [0425/000631.125715:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:06:31:INFO] [23988:40999:0425/000631.125996:18543887389751:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.SSLCertificateError/0 (34 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.SSLCertificateError/1 [12:06:31:INFO] [0425/000631.151273:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:06:31:INFO] [23988:141327:0425/000631.151446:18543912828517:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.SSLCertificateError/1 (25 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesSync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesSync/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesSync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesSync/1 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesAsync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesAsync/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesAsync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadMultiplePiecesAsync/1 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadChangesDefaultMethod/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadChangesDefaultMethod/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadChangesDefaultMethod/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadChangesDefaultMethod/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithSetMethod/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithSetMethod/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithSetMethod/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithSetMethod/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithBigRead/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithBigRead/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithBigRead/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithBigRead/1 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithDirectExecutor/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithDirectExecutor/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithDirectExecutor/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithDirectExecutor/1 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectSync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectSync/0 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectSync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectSync/1 (8 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectAsync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectAsync/0 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectAsync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRedirectAsync/1 (9 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLength/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLength/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLength/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLength/1 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLengthBufferAligned/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLengthBufferAligned/0 (53 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLengthBufferAligned/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadWithBadLengthBufferAligned/1 (100 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailSync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailSync/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailSync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailSync/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailAsync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailAsync/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailAsync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadReadFailAsync/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailSync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailSync/0 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailSync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailSync/1 (8 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailAsync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailAsync/0 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailAsync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadRewindFailAsync/1 (8 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadChunked/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadChunked/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadChunked/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadChunked/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadFailsWithoutInitializingStream/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadFailsWithoutInitializingStream/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadFailsWithoutInitializingStream/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadFailsWithoutInitializingStream/1 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadCancelReadAsync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadCancelReadAsync/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadCancelReadAsync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadCancelReadAsync/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadCancelRewindAsync/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadCancelRewindAsync/0 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.UploadCancelRewindAsync/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.UploadCancelRewindAsync/1 (7 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.SimpleRequest/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.SimpleRequest/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.SimpleRequest/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.SimpleRequest/1 (6 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.MultiRedirect/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.MultiRedirect/0 (12 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.MultiRedirect/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.MultiRedirect/1 (10 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.CancelRequest/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.CancelRequest/0 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.CancelRequest/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.CancelRequest/1 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.FailedRequestHostNotFound/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.FailedRequestHostNotFound/0 (4 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.FailedRequestHostNotFound/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.FailedRequestHostNotFound/1 (5 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.TestCancel/0 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.TestCancel/0 (46 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.TestCancel/1 [12:06:31:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.TestCancel/1 (52 ms) [12:06:31:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.PerfTest/0 [12:06:32:INFO] [23988:4611:0425/000632.415124:18545176477931:INFO:url_request_test.cc(1206)] Total time 626.978 ms [12:06:32:INFO] [23988:4611:0425/000632.416115:18545177478380:INFO:url_request_test.cc(1207)] Single Iteration time 62.6978 ms [12:06:32:INFO] [23988:4611:0425/000632.416215:18545177547330:INFO:url_request_test.cc(1214)] Average Throughput: 2463.56 mbps [12:06:32:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.PerfTest/0 (657 ms) [12:06:32:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.PerfTest/1 [12:06:33:INFO] [23988:4611:0425/000633.498349:18546259725367:INFO:url_request_test.cc(1206)] Total time 1066.15 ms [12:06:33:INFO] [23988:4611:0425/000633.498521:18546259834783:INFO:url_request_test.cc(1207)] Single Iteration time 106.615 ms [12:06:33:INFO] [23988:4611:0425/000633.498606:18546259912504:INFO:url_request_test.cc(1214)] Average Throughput: 1448.76 mbps [12:06:33:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.PerfTest/1 (1081 ms) [12:06:33:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.GetStatus/0 [12:06:33:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.GetStatus/0 (6 ms) [12:06:33:INFO] [ RUN ] NoRequestFinishedListener/UrlRequestTest.GetStatus/1 [12:06:33:INFO] [ OK ] NoRequestFinishedListener/UrlRequestTest.GetStatus/1 (8 ms) [12:06:33:INFO] [----------] 62 tests from NoRequestFinishedListener/UrlRequestTest (2479 ms total) [12:06:33:INFO] [12:06:33:INFO] [----------] 62 tests from RequestFinishedListenerOnUrlRequest/UrlRequestTest [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.InitChecks/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.InitChecks/0 (4 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.InitChecks/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.InitChecks/1 (3 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleGet/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleGet/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleGet/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleGet/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadEmptyBodySync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadEmptyBodySync/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadEmptyBodySync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadEmptyBodySync/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadSync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadSync/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadSync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadSync/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SSLCertificateError/0 [12:06:33:INFO] [0425/000633.595761:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:06:33:INFO] [23988:180255:0425/000633.595921:18546357231527:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SSLCertificateError/0 (24 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SSLCertificateError/1 [12:06:33:INFO] [0425/000633.621260:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:06:33:INFO] [23988:180259:0425/000633.621420:18546382729136:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SSLCertificateError/1 (25 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesSync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesSync/0 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesSync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesSync/1 (7 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesAsync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesAsync/0 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesAsync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadMultiplePiecesAsync/1 (7 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChangesDefaultMethod/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChangesDefaultMethod/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChangesDefaultMethod/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChangesDefaultMethod/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithSetMethod/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithSetMethod/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithSetMethod/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithSetMethod/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBigRead/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBigRead/0 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBigRead/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBigRead/1 (8 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithDirectExecutor/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithDirectExecutor/0 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithDirectExecutor/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithDirectExecutor/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectSync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectSync/0 (8 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectSync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectSync/1 (9 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectAsync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectAsync/0 (7 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectAsync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRedirectAsync/1 (9 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLength/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLength/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLength/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLength/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLengthBufferAligned/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLengthBufferAligned/0 (53 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLengthBufferAligned/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadWithBadLengthBufferAligned/1 (100 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailSync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailSync/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailSync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailSync/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailAsync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailAsync/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailAsync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadReadFailAsync/1 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailSync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailSync/0 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailSync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailSync/1 (7 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailAsync/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailAsync/0 (6 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailAsync/1 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadRewindFailAsync/1 (7 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunked/0 [12:06:33:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunked/0 (5 ms) [12:06:33:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunked/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunked/1 (7 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 (6 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 (7 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadFailsWithoutInitializingStream/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadFailsWithoutInitializingStream/0 (5 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadFailsWithoutInitializingStream/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadFailsWithoutInitializingStream/1 (6 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelReadAsync/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelReadAsync/0 (5 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelReadAsync/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelReadAsync/1 (6 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelRewindAsync/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelRewindAsync/0 (6 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelRewindAsync/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.UploadCancelRewindAsync/1 (8 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleRequest/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleRequest/0 (6 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleRequest/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.SimpleRequest/1 (6 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.MultiRedirect/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.MultiRedirect/0 (9 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.MultiRedirect/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.MultiRedirect/1 (9 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.CancelRequest/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.CancelRequest/0 (5 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.CancelRequest/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.CancelRequest/1 (6 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.FailedRequestHostNotFound/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.FailedRequestHostNotFound/0 (5 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.FailedRequestHostNotFound/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.FailedRequestHostNotFound/1 (5 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.TestCancel/0 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.TestCancel/0 (45 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.TestCancel/1 [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.TestCancel/1 (53 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.PerfTest/0 [12:06:34:INFO] [23988:4611:0425/000634.857372:18547618652184:INFO:url_request_test.cc(1206)] Total time 614.055 ms [12:06:34:INFO] [23988:4611:0425/000634.857487:18547618759215:INFO:url_request_test.cc(1207)] Single Iteration time 61.4055 ms [12:06:34:INFO] [23988:4611:0425/000634.857574:18547618837060:INFO:url_request_test.cc(1214)] Average Throughput: 2515.4 mbps [12:06:34:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.PerfTest/0 (628 ms) [12:06:34:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.PerfTest/1 [12:06:35:INFO] [23988:4611:0425/000635.929098:18548690373513:INFO:url_request_test.cc(1206)] Total time 1055.61 ms [12:06:35:INFO] [23988:4611:0425/000635.929257:18548690488818:INFO:url_request_test.cc(1207)] Single Iteration time 105.561 ms [12:06:35:INFO] [23988:4611:0425/000635.929329:18548690556436:INFO:url_request_test.cc(1214)] Average Throughput: 1463.23 mbps [12:06:35:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.PerfTest/1 (1070 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.GetStatus/0 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.GetStatus/0 (6 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.GetStatus/1 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnUrlRequest/UrlRequestTest.GetStatus/1 (8 ms) [12:06:35:INFO] [----------] 62 tests from RequestFinishedListenerOnUrlRequest/UrlRequestTest (2431 ms total) [12:06:35:INFO] [12:06:35:INFO] [----------] 62 tests from RequestFinishedListenerOnEngine/UrlRequestTest [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.InitChecks/0 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.InitChecks/0 (4 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.InitChecks/1 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.InitChecks/1 (4 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleGet/0 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleGet/0 (6 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleGet/1 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleGet/1 (7 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadEmptyBodySync/0 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadEmptyBodySync/0 (6 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadEmptyBodySync/1 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadEmptyBodySync/1 (7 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadSync/0 [12:06:35:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadSync/0 (6 ms) [12:06:35:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadSync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadSync/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.SSLCertificateError/0 [12:06:36:INFO] [0425/000636.027514:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:06:36:INFO] [23988:197423:0425/000636.027635:18548788868737:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.SSLCertificateError/0 (25 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.SSLCertificateError/1 [12:06:36:INFO] [0425/000636.053382:ERROR:ssl_client_socket_impl.cc(947)] handshake failed; returned -1, SSL error code 1, net_error -207 [12:06:36:INFO] [23988:197427:0425/000636.053535:18548814769775:ERROR:ssl_server_socket_impl.cc(686)] handshake failed; returned -1, SSL error code 1, net_error -117 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.SSLCertificateError/1 (25 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesSync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesSync/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesSync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesSync/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesAsync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesAsync/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesAsync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadMultiplePiecesAsync/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChangesDefaultMethod/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChangesDefaultMethod/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChangesDefaultMethod/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChangesDefaultMethod/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithSetMethod/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithSetMethod/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithSetMethod/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithSetMethod/1 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBigRead/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBigRead/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBigRead/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBigRead/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithDirectExecutor/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithDirectExecutor/0 (5 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithDirectExecutor/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithDirectExecutor/1 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectSync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectSync/0 (8 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectSync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectSync/1 (9 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectAsync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectAsync/0 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectAsync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRedirectAsync/1 (9 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLength/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLength/0 (5 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLength/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLength/1 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLengthBufferAligned/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLengthBufferAligned/0 (54 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLengthBufferAligned/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadWithBadLengthBufferAligned/1 (101 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailSync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailSync/0 (5 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailSync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailSync/1 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailAsync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailAsync/0 (5 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailAsync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadReadFailAsync/1 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailSync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailSync/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailSync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailSync/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailAsync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailAsync/0 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailAsync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadRewindFailAsync/1 (8 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunked/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunked/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunked/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunked/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadFailsWithoutInitializingStream/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadFailsWithoutInitializingStream/0 (4 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadFailsWithoutInitializingStream/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadFailsWithoutInitializingStream/1 (5 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelReadAsync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelReadAsync/0 (5 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelReadAsync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelReadAsync/1 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelRewindAsync/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelRewindAsync/0 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelRewindAsync/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.UploadCancelRewindAsync/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleRequest/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleRequest/0 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleRequest/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.SimpleRequest/1 (7 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.MultiRedirect/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.MultiRedirect/0 (10 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.MultiRedirect/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.MultiRedirect/1 (10 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.CancelRequest/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.CancelRequest/0 (5 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.CancelRequest/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.CancelRequest/1 (6 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.FailedRequestHostNotFound/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.FailedRequestHostNotFound/0 (4 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.FailedRequestHostNotFound/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.FailedRequestHostNotFound/1 (4 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.TestCancel/0 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.TestCancel/0 (46 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.TestCancel/1 [12:06:36:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.TestCancel/1 (54 ms) [12:06:36:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.PerfTest/0 [12:06:37:INFO] [23988:4611:0425/000637.294429:18550055636726:INFO:url_request_test.cc(1206)] Total time 612.161 ms [12:06:37:INFO] [23988:4611:0425/000637.294545:18550055733689:INFO:url_request_test.cc(1207)] Single Iteration time 61.2161 ms [12:06:37:INFO] [23988:4611:0425/000637.294613:18550055795587:INFO:url_request_test.cc(1214)] Average Throughput: 2523.18 mbps [12:06:37:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.PerfTest/0 (627 ms) [12:06:37:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.PerfTest/1 [12:06:38:INFO] [23988:4611:0425/000638.366394:18551127596235:INFO:url_request_test.cc(1206)] Total time 1055.79 ms [12:06:38:INFO] [23988:4611:0425/000638.366553:18551127709158:INFO:url_request_test.cc(1207)] Single Iteration time 105.579 ms [12:06:38:INFO] [23988:4611:0425/000638.366623:18551127781102:INFO:url_request_test.cc(1214)] Average Throughput: 1462.98 mbps [12:06:38:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.PerfTest/1 (1070 ms) [12:06:38:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.GetStatus/0 [12:06:38:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.GetStatus/0 (6 ms) [12:06:38:INFO] [ RUN ] RequestFinishedListenerOnEngine/UrlRequestTest.GetStatus/1 [12:06:38:INFO] [ OK ] RequestFinishedListenerOnEngine/UrlRequestTest.GetStatus/1 (7 ms) [12:06:38:INFO] [----------] 62 tests from RequestFinishedListenerOnEngine/UrlRequestTest (2437 ms total) [12:06:38:INFO] [12:06:38:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 (39 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 (38 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 (38 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 (38 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 (37 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 (37 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 (38 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 (37 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 (37 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 (38 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 (38 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 (37 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 (37 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 (38 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 [12:06:38:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 (37 ms) [12:06:38:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/1 (38 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 (37 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 (37 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 (37 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 (38 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 [12:06:39:INFO] [0425/000639.176340:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 (9 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 [12:06:39:INFO] [0425/000639.186391:ERROR:bidirectional_stream.cc(286)] Unexpected Read Data in read_state 0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 (9 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/0 (37 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeReadIsExecutedOnNetworkThread/1 (38 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 [12:06:39:INFO] [0425/000639.275130:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 (9 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 [12:06:39:INFO] [0425/000639.285184:ERROR:bidirectional_stream.cc(315)] Unexpected Flush Data in write_state 0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 (9 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 (36 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 (36 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 [12:06:39:INFO] [0425/000639.399558:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed. [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 (38 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 [12:06:39:INFO] [0425/000639.438160:ERROR:bidirectional_stream_quic_impl.cc(175)] Trying to send data after stream has been closed. [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 (37 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 (9 ms) [12:06:39:INFO] [ RUN ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 [12:06:39:INFO] [ OK ] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 (9 ms) [12:06:39:INFO] [----------] 32 tests from BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest (1076 ms total) [12:06:39:INFO] [12:06:39:INFO] [----------] 5 tests from Loops/PerfTest [12:06:39:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0 [12:06:39:INFO] [23988:4611:0425/000639.471001:18552232185240:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 0 AKD4: 0 Cronet: 0 [12:06:39:INFO] [23988:4611:0425/000639.471161:18552232283970:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:06:40:INFO] [23988:4611:0425/000640.075250:18552836384474:INFO:cronet_performance_test.mm(253)] Elapsed Total:592.762ms [12:06:40:INFO] [0425/000640.079204:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:06:40:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/0 (617 ms) [12:06:40:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1 [12:06:40:INFO] [23988:4611:0425/000640.091520:18552852653826:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 0 AKD4: 0 Cronet: 1 [12:06:40:INFO] [23988:4611:0425/000640.091647:18552852755157:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:06:40:INFO] [23988:4611:0425/000640.641247:18553402355633:INFO:cronet_performance_test.mm(253)] Elapsed Total:538.016ms [12:06:40:INFO] [0425/000640.644626:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:06:40:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/1 (564 ms) [12:06:40:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2 [12:06:40:INFO] [23988:4611:0425/000640.655714:18553416817015:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 0 HTTP2: 1 AKD4: 0 Cronet: 1 [12:06:40:INFO] [23988:4611:0425/000640.655826:18553416917018:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:06:41:INFO] [23988:4611:0425/000641.195463:18553956582198:INFO:cronet_performance_test.mm(253)] Elapsed Total:527.6ms [12:06:41:INFO] [0425/000641.199009:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:06:41:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/2 (552 ms) [12:06:41:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3 [12:06:41:INFO] [23988:4611:0425/000641.209861:18553970959000:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1 HTTP2: 0 AKD4: 0 Cronet: 1 [12:06:41:INFO] [23988:4611:0425/000641.209992:18553971070788:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:06:41:INFO] [23988:4611:0425/000641.729958:18554491068087:INFO:cronet_performance_test.mm(253)] Elapsed Total:508.284ms [12:06:41:INFO] [0425/000641.733320:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:06:41:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/3 (533 ms) [12:06:41:INFO] [ RUN ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4 [12:06:41:INFO] [23988:4611:0425/000641.744070:18554505140515:INFO:cronet_performance_test.mm(181)] Running with parameters: QUIC: 1 HTTP2: 0 AKD4: 1 Cronet: 1 [12:06:41:INFO] [23988:4611:0425/000641.744172:18554505225606:INFO:cronet_performance_test.mm(191)] Downloading 19307439 bytes per iteration [12:06:42:INFO] [23988:4611:0425/000642.280424:18555041509308:INFO:cronet_performance_test.mm(253)] Elapsed Total:524.588ms [12:06:42:INFO] [0425/000642.283718:WARNING:url_request_context_getter.cc(43)] URLRequestContextGetter leaking due to no owning thread. [12:06:42:INFO] [ OK ] Loops/PerfTest.NSURLSessionReceivesImageLoop/4 (549 ms) [12:06:42:INFO] [23988:4611:0425/000642.286080:18555047141557:INFO:cronet_performance_test.mm(71)] Performance Data: [12:06:42:INFO] [23988:4611:0425/000642.286210:18555047250915:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 0 AKD4 0 Cronet 0: Mean: 0.059276s (2605.758848mbps) Max: 0.064868s with 0 fails out of 10 total requests. [12:06:42:INFO] [23988:4611:0425/000642.286300:18555047340621:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 0 AKD4 0 Cronet 1: Mean: 0.053802s (2870.910107mbps) Max: 0.057714s with 0 fails out of 10 total requests. [12:06:42:INFO] [23988:4611:0425/000642.286398:18555047442817:INFO:cronet_performance_test.mm(88)] Quic 0 Http2 1 AKD4 0 Cronet 1: Mean: 0.052760s (2927.587799mbps) Max: 0.057924s with 0 fails out of 10 total requests. [12:06:42:INFO] [23988:4611:0425/000642.286498:18555047540187:INFO:cronet_performance_test.mm(88)] Quic 1 Http2 0 AKD4 0 Cronet 1: Mean: 0.050828s (3038.842857mbps) Max: 0.054744s with 0 fails out of 10 total requests. [12:06:42:INFO] [23988:4611:0425/000642.286597:18555047640364:INFO:cronet_performance_test.mm(88)] Quic 1 Http2 0 AKD4 1 Cronet 1: Mean: 0.052459s (2944.398663mbps) Max: 0.056563s with 0 fails out of 10 total requests. [12:06:42:INFO] [----------] 5 tests from Loops/PerfTest (2823 ms total) [12:06:42:INFO] [12:06:42:INFO] [----------] Global test environment tear-down [12:06:42:INFO] [==========] 296 tests from 17 test suites ran. (84011 ms total) [12:06:42:INFO] [ PASSED ] 296 tests. [12:06:42:INFO] [12:06:42:INFO] YOU HAVE 14 DISABLED TESTS [12:06:42:INFO] [12:07:01:INFO] Testing started on 'iPhone X' [12:07:01:INFO] 2019-04-25 00:04:59.516 xcodebuild[23866:337343] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [12:07:01:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-gneleonfwklxnoehtvqyeluqgkvk/Logs/Test/Test-Transient Testing-2019.04.25_00-04-59--0700.xcresult/1_Test/Diagnostics/cronet_test-E22A8B59-F4DF-4034-9ADE-2184615F5FC7/cronet_test-E0CC3091-854E-4F79-B4B7-388CFA5E8EFF/Session-cronet_test-2019-04-25_000459-CoQHy0.log [12:07:01:INFO] 2019-04-25 00:04:59.516 xcodebuild[23866:337315] [MT] IDETestOperationsObserverDebug: (66F69A92-B7A2-4A3D-8856-94C4A333D9A7) Beginning test session cronet_test-66F69A92-B7A2-4A3D-8856-94C4A333D9A7 at 2019-04-25 00:04:59.517 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7f83b37af870> { [12:07:01:INFO] SimDevice: iPhone X (219CD6ED-0AA6-40D4-B86D-0139D5872524, iOS 12.1, Shutdown) [12:07:01:INFO] } (12.1 (16B91)) [12:07:01:INFO] 2019-04-25 00:06:55.644 xcodebuild[23866:337315] [MT] IDETestOperationsObserverDebug: 116.253 elapsed -- Testing started completed. [12:07:01:INFO] 2019-04-25 00:06:55.645 xcodebuild[23866:337315] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [12:07:01:INFO] 2019-04-25 00:06:55.645 xcodebuild[23866:337315] [MT] IDETestOperationsObserverDebug: 116.253 sec, +116.253 sec -- end [12:07:01:DEBUG] Finished print_process_output. [12:07:01:INFO] Waiting for test process to terminate. [12:07:01:INFO] Test process terminated. [12:07:01:DEBUG] Setting sigterm handler. [12:07:01:DEBUG] Stdout flushed after test process. [12:07:01:DEBUG] Processing test results. [12:07:01:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 65 [12:07:01:DEBUG] Extracting test data. [12:07:01:DEBUG] Retrieving crash reports. [12:07:01:DEBUG] Retrieving derived data. [12:07:01:DEBUG] Making desktop screenshots. [12:07:02:DEBUG] Killing simulators. [12:07:07:DEBUG] Wiping simulator. Device wiped. [12:07:08:DEBUG] End of tear_down. 2019-04-25 00:08:33,125 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/6ksAslM/446c21003b157d10'] 2019-04-25 00:08:33,125 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/6ksAslM/446c21003b157d10/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/6ksAslM/446c21003b157d10/output.json'] 2019-04-25 00:08:33,125 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/6ksAslM' Found ['/b/s/w/ir/k/recipe_cleanup/6ksAslM/446c21003b157d10'] 2019-04-25 00:08:33,126 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/6ksAslM/446c21003b157d10/output.json'] 2019-04-25 00:08:33,126 - 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/tmpt4eQ4W.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/6ksAslM -o /b/s/w/ir/tmp/t/tmpei0KNT.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/tmpt4eQ4W.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/6ksAslM', '-o', '/b/s/w/ir/tmp/t/tmpei0KNT.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/tmpt4eQ4W.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/6ksAslM', '-o', '/b/s/w/ir/tmp/t/tmpei0KNT.json'] returned exit code 0