Skip to content

Instantly share code, notes, and snippets.

@mzabsky

mzabsky/grpc client error

Created April 18, 2019 12:54
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save mzabsky/7be3d6720d2f20656244de171541eb81 to your computer and use it in GitHub Desktop.
Save mzabsky/7be3d6720d2f20656244de171541eb81 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
grpc client error
D0418 14:53:48.466425 Grpc.Core.Internal.UnmanagedLibrary Attempting to load native library "C:\Users\matej.zabsky\.nuget\packages\grpc.core\1.17.0\lib\netstandard1.5\../..\runtimes/win/native\grpc_csharp_ext.x64.dll"
D0418 14:53:48.506634 Grpc.Core.Internal.NativeExtension gRPC native library loaded successfully.
D0418 14:53:48.510356 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\resolver\dns\native\dns_resolver.cc:338: Using native dns resolver
I0418 14:53:48.510694 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_manager.cc:93: Spawn timer thread
I0418 14:53:48.510949 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\init.cc:154: grpc_init(void)
I0418 14:53:48.515300 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:715: TIMER CHECK BEGIN: now=3 next=9223372036854775807 tls_min=0 glob_min=0
I0418 14:53:48.515486 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:610: .. shard[0]->min_deadline = 1
I0418 14:53:48.515568 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[0]: heap_empty=true
I0418 14:53:48.515638 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[0]->queue_deadline_cap --> 1003
I0418 14:53:48.515693 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[0] popped 0
I0418 14:53:48.515904 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[0]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.516086 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[1]: heap_empty=true
I0418 14:53:48.518109 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[1]->queue_deadline_cap --> 1003
I0418 14:53:48.518189 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[1] popped 0
I0418 14:53:48.518248 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[1]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.518296 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[2]: heap_empty=true
I0418 14:53:48.518385 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[2]->queue_deadline_cap --> 1003
I0418 14:53:48.519258 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[2] popped 0
I0418 14:53:48.532161 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[2]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.532314 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[3]: heap_empty=true
I0418 14:53:48.532953 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[3]->queue_deadline_cap --> 1003
I0418 14:53:48.533580 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[3] popped 0
I0418 14:53:48.539512 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[3]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.539663 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[4]: heap_empty=true
I0418 14:53:48.540257 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[4]->queue_deadline_cap --> 1003
I0418 14:53:48.540636 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[4] popped 0
I0418 14:53:48.541306 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[4]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.541631 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[5]: heap_empty=true
I0418 14:53:48.541952 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[5]->queue_deadline_cap --> 1003
I0418 14:53:48.542312 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[5] popped 0
I0418 14:53:48.542749 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[5]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.543182 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[6]: heap_empty=true
I0418 14:53:48.543609 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[6]->queue_deadline_cap --> 1003
I0418 14:53:48.544000 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[6] popped 0
I0418 14:53:48.551331 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[6]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.556483 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[7]: heap_empty=true
I0418 14:53:48.556672 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[7]->queue_deadline_cap --> 1003
I0418 14:53:48.557046 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[7] popped 0
I0418 14:53:48.557662 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[7]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.557872 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:481: grpc_completion_queue_create_internal(completion_type=0, polling_type=0)
I0418 14:53:48.558424 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[8]: heap_empty=true
I0418 14:53:48.560112 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:481: grpc_completion_queue_create_internal(completion_type=0, polling_type=0)
I0418 14:53:48.560382 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[8]->queue_deadline_cap --> 1003
I0418 14:53:48.561787 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:481: grpc_completion_queue_create_internal(completion_type=0, polling_type=0)
I0418 14:53:48.562050 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[8] popped 0
I0418 14:53:48.562342 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:481: grpc_completion_queue_create_internal(completion_type=0, polling_type=0)
I0418 14:53:48.562674 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[8]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.564280 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[9]: heap_empty=true
I0418 14:53:48.564609 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[9]->queue_deadline_cap --> 1003
I0418 14:53:48.564886 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[9] popped 0
I0418 14:53:48.565193 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[9]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.565517 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[10]: heap_empty=true
I0418 14:53:48.567119 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[10]->queue_deadline_cap --> 1003
I0418 14:53:48.571960 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[10] popped 0
I0418 14:53:48.572521 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[10]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.572820 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[11]: heap_empty=true
I0418 14:53:48.573113 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[11]->queue_deadline_cap --> 1003
I0418 14:53:48.573437 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[11] popped 0
I0418 14:53:48.573771 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[11]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.574194 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[12]: heap_empty=true
I0418 14:53:48.574823 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[12]->queue_deadline_cap --> 1003
I0418 14:53:48.577701 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[12] popped 0
I0418 14:53:48.577891 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[12]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.581354 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[13]: heap_empty=true
I0418 14:53:48.582200 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[13]->queue_deadline_cap --> 1003
I0418 14:53:48.584374 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[13] popped 0
I0418 14:53:48.584581 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[13]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.585229 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[14]: heap_empty=true
I0418 14:53:48.587664 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[14]->queue_deadline_cap --> 1003
I0418 14:53:48.587807 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[14] popped 0
I0418 14:53:48.587908 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:963: grpc_completion_queue_next(cq=000001CE15A0AB40, deadline=gpr_timespec { tv_sec: 9223372036854775807, tv_nsec: 0, clock_type: 1 }, reserved=0000000000000000)
I0418 14:53:48.587934 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:963: grpc_completion_queue_next(cq=000001CE15AAEEB0, deadline=gpr_timespec { tv_sec: 9223372036854775807, tv_nsec: 0, clock_type: 1 }, reserved=0000000000000000)
I0418 14:53:48.587938 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:963: grpc_completion_queue_next(cq=000001CE15A00DE0, deadline=gpr_timespec { tv_sec: 9223372036854775807, tv_nsec: 0, clock_type: 1 }, reserved=0000000000000000)
I0418 14:53:48.587970 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:963: grpc_completion_queue_next(cq=000001CE14168F60, deadline=gpr_timespec { tv_sec: 9223372036854775807, tv_nsec: 0, clock_type: 1 }, reserved=0000000000000000)
I0418 14:53:48.588174 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[14]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.589322 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\init.cc:154: grpc_init(void)
I0418 14:53:48.594191 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:533: .. shard[15]: heap_empty=true
I0418 14:53:48.594677 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\client\insecure\channel_create.cc:93: grpc_insecure_channel_create(target=127.0.0.1:50051, args=000001CE15A1EF00, reserved=0000000000000000)
I0418 14:53:48.594791 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:508: .. shard[15]->queue_deadline_cap --> 1003
I0418 14:53:48.595187 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:365: TIMER 000001CE15A44340: SET 5087 now 87 call 000001CE15A44370[00007FFA8B1ABA00]
I0418 14:53:48.595430 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:573: .. shard[15] popped 0
I0418 14:53:48.595786 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:401: .. add to shard 4 with queue_deadline_cap=1003 => is_first_timer=false
I0418 14:53:48.596041 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:628: .. result --> 1, shard[15]->min_deadline 1 --> 1004, now=3
I0418 14:53:48.596341 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\channel.cc:285: grpc_channel_get_target(channel=000001CE15A236E0)
I0418 14:53:48.596648 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:738: TIMER CHECK END: r=1; next=1004
I0418 14:53:48.597399 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_manager.cc:185: sleep for a 1001 milliseconds
I0418 14:53:48.613514 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:481: grpc_completion_queue_create_internal(completion_type=1, polling_type=0)
I0418 14:53:48.635681 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:1903: grpc_call_start_batch(call=000001CE15AAF030, ops=000000C1D199C8E0, nops=6, tag=000001CE15A44E40, reserved=0000000000000000)
I0418 14:53:48.635835 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:1508: ops[0]: SEND_INITIAL_METADATA(nil)
I0418 14:53:48.638028 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:1508: ops[1]: SEND_MESSAGE ptr=000001CE15A23910
I0418 14:53:48.639530 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:1508: ops[2]: SEND_CLOSE_FROM_CLIENT
I0418 14:53:48.639774 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:1508: ops[3]: RECV_INITIAL_METADATA ptr=000001CE15A44E78
I0418 14:53:48.640028 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:1508: ops[4]: RECV_MESSAGE ptr=000001CE15A44E90
I0418 14:53:48.640301 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:1508: ops[5]: RECV_STATUS_ON_CLIENT metadata=000001CE15A44E98 status=000001CE15A44EB0 details=000001CE15A44EB8
I0418 14:53:48.640624 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:69: ==> grpc_call_combiner_start() [000001CE15AAF040] closure=000001CE15AAFF48 [executing batch] error="No Error"
I0418 14:53:48.640879 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:78: size: 0 -> 1
I0418 14:53:48.641132 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:87: EXECUTING IMMEDIATELY
I0418 14:53:48.641433 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:613: OP[client-channel:000001CE15AAF9B0]: SEND_INITIAL_METADATA{key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0418 14:53:48.641950 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:1204: chand=000001CE15A237B0 calld=000001CE15AAF9D0: adding pending batch at index 0
I0418 14:53:48.642188 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:3197: chand=000001CE15A237B0 calld=000001CE15AAF9D0: entering client_channel combiner
I0418 14:53:48.642489 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:243: chand=000001CE15A237B0: starting name resolution
D0418 14:53:48.642876 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\resolver\dns\native\dns_resolver.cc:279: Start resolving.
I0418 14:53:48.643322 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:243: EXECUTOR (resolver-executor) try to schedule 000001CE15A3F240 (short) to thread 0
I0418 14:53:48.643619 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:2951: chand=000001CE15A237B0 calld=000001CE15AAF9D0: deferring pick pending resolver result
I0418 14:53:48.651499 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:167: call_combiner=000001CE15AAF040: setting notify_on_cancel=000001CE141A0E10
I0418 14:53:48.651558 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:188: EXECUTOR (resolver-executor) [0]: execute
I0418 14:53:48.652072 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:1206: grpc_completion_queue_pluck(cq=000001CE15A69840, tag=000001CE15A44E40, deadline=gpr_timespec { tv_sec: 9223372036854775807, tv_nsec: 0, clock_type: 1 }, reserved=0000000000000000)
I0418 14:53:48.652955 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:73: EXECUTOR (resolver-executor) run 000001CE15A3F240
I0418 14:53:48.664240 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:438: chand=000001CE15A237B0: got resolver result: resolver_result=000001CE15A23210 error="No Error"
I0418 14:53:48.664434 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\lb_policy\pick_first\pick_first.cc:161: Pick First 000001CE15AB44A0 created.
I0418 14:53:48.665023 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\lb_policy\pick_first\pick_first.cc:360: Pick First 000001CE15AB44A0 received update with 1 addresses
I0418 14:53:48.665285 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:501: [pick_first 000001CE15AB44A0] Creating subchannel list 000001CE15AB7AA0 for 1 subchannels
I0418 14:53:48.665626 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:546: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0: Created subchannel 000001CE15A5AAD0 for address uri ipv4:10.240.240.1:8080
I0418 14:53:48.666030 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:340: chand=000001CE15A237B0: created new LB policy "pick_first" (000001CE15AB44A0)
I0418 14:53:48.666367 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:92: CONWATCH: 000001CE15AB45D0 pick_first: get IDLE
I0418 14:53:48.666638 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15AB45D0 pick_first: from IDLE [cur=IDLE] notify=000001CE15A3FD28
I0418 14:53:48.667035 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:196: chand=000001CE15A237B0: setting connectivity state to IDLE
I0418 14:53:48.667243 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A23838 client_channel: IDLE --> IDLE [resolver_result] error=0000000000000000 "No Error"
I0418 14:53:48.667478 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:3040: chand=000001CE15A237B0 calld=000001CE15AAF9D0: resolver returned, doing LB pick
I0418 14:53:48.667736 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:2855: chand=000001CE15A237B0 calld=000001CE15AAF9D0: applying service config to call
I0418 14:53:48.667984 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:81: CONWATCH: 000001CE15A23838 client_channel: get IDLE
I0418 14:53:48.668244 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:2763: chand=000001CE15A237B0 calld=000001CE15AAF9D0: starting pick on lb_policy=000001CE15AB44A0
I0418 14:53:48.670961 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:92: CONWATCH: 000001CE15A5ABC0 subchannel: get IDLE
I0418 14:53:48.671225 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:332: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0 of 1 (subchannel 000001CE15A5AAD0): starting watch: requesting connectivity change notification (from IDLE)
I0418 14:53:48.671727 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15A5ABC0 subchannel: from IDLE [cur=IDLE] notify=000001CE159FCD78
I0418 14:53:48.672018 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A5ABC0 subchannel: IDLE --> CONNECTING [connecting] error=0000000000000000 "No Error"
I0418 14:53:48.672280 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:190: NOTIFY: 000001CE15A5ABC0 subchannel: 000001CE159FCD78
I0418 14:53:48.672620 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A5ABE0 subchannel: IDLE --> CONNECTING [connecting] error=0000000000000000 "No Error"
I0418 14:53:48.673156 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:365: TIMER 000001CE1412BE10: SET 20158 now 158 call 000001CE1412BE40[00007FFA8B1EAD10]
I0418 14:53:48.673558 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:401: .. add to shard 4 with queue_deadline_cap=1003 => is_first_timer=false
I0418 14:53:48.673683 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:167: call_combiner=000001CE15AAF040: setting notify_on_cancel=000001CE15AAFB98
I0418 14:53:48.674876 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:176: call_combiner=000001CE15AAF040: scheduling old cancel callback=000001CE141A0E10
I0418 14:53:48.675495 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:467: TIMER 000001CE1412BE10: CANCEL pending=true
I0418 14:53:48.680700 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\handshaker.cc:141: handshake_manager 000001CE15AB95E0: adding handshaker http_connect [000001CE15AB9730] at index 0
I0418 14:53:48.684361 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:365: TIMER 000001CE15AB9668: SET 20158 now 158 call 000001CE15AB9698[00007FFA8B1C1920]
I0418 14:53:48.684661 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:401: .. add to shard 3 with queue_deadline_cap=1003 => is_first_timer=false
I0418 14:53:48.685055 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\handshaker.cc:212: handshake_manager 000001CE15AB95E0: error="No Error" shutdown=0 index=0, args={endpoint=000001CE14148750, args=000001CE15A230D0 {size=7: grpc.primary_user_agent=grpc-csharp/1.17.0, grpc.client_channel_factory=00007FFA8B467038, grpc.server_uri=dns:///127.0.0.1:50051, grpc.channelz_channel_node_creation_func=00007FFA8B0F819D, grpc.http_connect_server=127.0.0.1:50051, grpc.default_authority=127.0.0.1:50051, grpc.subchannel_address=ipv4:10.240.240.1:8080}, read_buffer=000001CE15A02D60 (length=0), exit_early=0}
I0418 14:53:48.686140 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\handshaker.cc:258: handshake_manager 000001CE15AB95E0: calling handshaker http_connect [000001CE15AB9730] at index 0
I0418 14:53:48.687667 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\http_connect_handshaker.cc:300: Connecting to server 127.0.0.1:50051 via HTTP proxy ipv4:10.240.240.1:8080
I0418 14:53:48.688050 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:447: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0 of 1 (subchannel 000001CE15A5AAD0): connectivity changed: state=CONNECTING, error="No Error", shutting_down=0
I0418 14:53:48.688562 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15AB45D0 pick_first: IDLE --> CONNECTING [connecting_changed] error=0000000000000000 "No Error"
I0418 14:53:48.689047 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:190: NOTIFY: 000001CE15AB45D0 pick_first: 000001CE15A3FD28
I0418 14:53:48.689254 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\handshaker.cc:212: handshake_manager 000001CE15AB95E0: error="No Error" shutdown=0 index=1, args={endpoint=000001CE14148750, args=000001CE15A230D0 {size=7: grpc.primary_user_agent=grpc-csharp/1.17.0, grpc.client_channel_factory=00007FFA8B467038, grpc.server_uri=dns:///127.0.0.1:50051, grpc.channelz_channel_node_creation_func=00007FFA8B0F819D, grpc.http_connect_server=127.0.0.1:50051, grpc.default_authority=127.0.0.1:50051, grpc.subchannel_address=ipv4:10.240.240.1:8080}, read_buffer=000001CE15A02D60 (length=0), exit_early=0}
I0418 14:53:48.689356 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:354: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0 of 1 (subchannel 000001CE15A5AAD0): renewing watch: requesting connectivity change notification (from CONNECTING)
I0418 14:53:48.690141 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\handshaker.cc:245: handshake_manager 000001CE15AB95E0: handshaking complete -- scheduling on_handshake_done with error="No Error"
I0418 14:53:48.690764 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15A5ABC0 subchannel: from CONNECTING [cur=CONNECTING] notify=000001CE159FCA78
I0418 14:53:48.691130 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:467: TIMER 000001CE15AB9668: CANCEL pending=true
I0418 14:53:48.691453 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:214: chand=000001CE15A237B0: lb_policy=000001CE15AB44A0 state changed to CONNECTING
I0418 14:53:48.691804 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/lib/transport/bdp_estimator.h:53: bdp[ipv4:10.240.240.1:8080]:sched acc=0 est=65536
I0418 14:53:48.692070 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:196: chand=000001CE15A237B0: setting connectivity state to CONNECTING
I0418 14:53:48.692397 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state IDLE -> WRITING [TRANSPORT_FLOW_CONTROL]
I0418 14:53:48.692929 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A23838 client_channel: IDLE --> CONNECTING [lb_changed] error=0000000000000000 "No Error"
I0418 14:53:48.695566 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING -> WRITING+MORE [INITIAL_WRITE]
I0418 14:53:48.695938 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15AB45D0 pick_first: from CONNECTING [cur=CONNECTING] notify=000001CE15A3FF08
I0418 14:53:48.696956 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\subchannel.cc:841: New connected subchannel at 000001CE15ABC450 for subchannel 000001CE15A5AAD0
I0418 14:53:48.697220 1984612415280 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:167: EXECUTOR (resolver-executor) [0]: step (sub_depth=1)
I0418 14:53:48.697526 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1866: perform_transport_op[t=000001CE15ABC980]: ON_CONNECTIVITY_STATE_CHANGE:p=000001CE15A57F08:from=READY BIND_POLLSET_SET
I0418 14:53:48.698863 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A5ABC0 subchannel: CONNECTING --> READY [subchannel_connected] error=0000000000000000 "No Error"
I0418 14:53:48.699165 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:190: NOTIFY: 000001CE15A5ABC0 subchannel: 000001CE159FCA78
I0418 14:53:48.700234 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A5ABE0 subchannel: CONNECTING --> READY [subchannel_connected] error=0000000000000000 "No Error"
I0418 14:53:48.700601 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15ABCC28 client_transport: from READY [cur=READY] notify=000001CE15A57F08
D0418 14:53:48.700822 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\flow_control.cc:113: 000001CE15ABDFC8[0][cli] | t updt sent | trw: 65535, ttw: 4194304, taw: 65535 -> 4194304, srw: , slw: , saw:
I0418 14:53:48.701364 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\writing.cc:110: CLIENT: Ping sent [000001CE15A23130]: 2/2
I0418 14:53:48.701617 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING+MORE -> WRITING [begin write in current thread]
I0418 14:53:48.701901 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:2596: ipv4:10.240.240.1:8080: Start BDP ping err="No Error"
I0418 14:53:48.702142 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/lib/transport/bdp_estimator.h:66: bdp[ipv4:10.240.240.1:8080]:start acc=0 est=65536
I0418 14:53:48.702510 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING -> IDLE [finish writing]
I0418 14:53:48.702816 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:447: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0 of 1 (subchannel 000001CE15A5AAD0): connectivity changed: state=READY, error="No Error", shutting_down=0
I0418 14:53:48.703421 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15AB45D0 pick_first: CONNECTING --> READY [subchannel_ready] error=0000000000000000 "No Error"
I0418 14:53:48.703736 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:190: NOTIFY: 000001CE15AB45D0 pick_first: 000001CE15A3FF08
I0418 14:53:48.704101 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\lb_policy\pick_first\pick_first.cc:591: Pick First 000001CE15AB44A0 selected subchannel 000001CE15A5AAD0
I0418 14:53:48.706683 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\lb_policy\pick_first\pick_first.cc:599: Servicing pending pick with selected subchannel 000001CE15A5AAD0
I0418 14:53:48.707146 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:354: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0 of 1 (subchannel 000001CE15A5AAD0): renewing watch: requesting connectivity change notification (from READY)
I0418 14:53:48.709497 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15A5ABC0 subchannel: from READY [cur=READY] notify=000001CE159FCEF8
I0418 14:53:48.709892 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:214: chand=000001CE15A237B0: lb_policy=000001CE15AB44A0 state changed to READY
I0418 14:53:48.710448 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:196: chand=000001CE15A237B0: setting connectivity state to READY
I0418 14:53:48.711856 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A23838 client_channel: CONNECTING --> READY [lb_changed] error=0000000000000000 "No Error"
I0418 14:53:48.712168 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15AB45D0 pick_first: from READY [cur=READY] notify=000001CE15A3F288
I0418 14:53:48.713403 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:2819: chand=000001CE15A237B0 calld=000001CE15AAF9D0: pick completed asynchronously
I0418 14:53:48.714673 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:2669: chand=000001CE15A237B0 calld=000001CE15AAF9D0: create subchannel_call=000001CE2E5620C0: error="No Error"
I0418 14:53:48.715908 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:1346: chand=000001CE15A237B0 calld=000001CE15AAF9D0: starting 1 pending batches on subchannel_call=000001CE2E5620C0
I0418 14:53:48.718488 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/lib/iomgr/call_combiner.h:153: CallCombinerClosureList executing closure while already holding call_combiner 000001CE15AAF040: closure=000001CE15AAFEF8 error="No Error" reason=pending_batches_resume
I0418 14:53:48.723253 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\subchannel.cc:1000: OP[authority:000001CE2E562160]: SEND_INITIAL_METADATA{key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0418 14:53:48.726190 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\channel_stack.cc:226: OP[message_size:000001CE2E562178]: SEND_INITIAL_METADATA{key=3a 61 75 74 68 6f 72 69 74 79 ':authority' value=31 32 37 2e 30 2e 30 2e 31 3a 35 30 30 35 31 '127.0.0.1:50051', key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0418 14:53:48.729729 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\channel_stack.cc:226: OP[http-client:000001CE2E562190]: SEND_INITIAL_METADATA{key=3a 61 75 74 68 6f 72 69 74 79 ':authority' value=31 32 37 2e 30 2e 30 2e 31 3a 35 30 30 35 31 '127.0.0.1:50051', key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0418 14:53:48.733543 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\channel_stack.cc:226: OP[message_compress:000001CE2E5621A8]: SEND_INITIAL_METADATA{key=3a 73 63 68 65 6d 65 ':scheme' value=68 74 74 70 'http', key=3a 6d 65 74 68 6f 64 ':method' value=50 4f 53 54 'POST', key=3a 61 75 74 68 6f 72 69 74 79 ':authority' value=31 32 37 2e 30 2e 30 2e 31 3a 35 30 30 35 31 '127.0.0.1:50051', key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello', key=74 65 'te' value=74 72 61 69 6c 65 72 73 'trailers', key=63 6f 6e 74 65 6e 74 2d 74 79 70 65 'content-type' value=61 70 70 6c 69 63 61 74 69 6f 6e 2f 67 72 70 63 'application/grpc', key=75 73 65 72 2d 61 67 65 6e 74 'user-agent' value=67 72 70 63 2d 63 73 68 61 72 70 2f 31 2e 31 37 2e 30 20 67 72 70 63 2d 63 2f 37 2e 30 2e 30 20 28 77 69 6e 64 6f 77 73 3b 20 63 68 74 74 70 32 3b 20 67 69 7a 6d 6f 29 'grpc-csharp/1.17.0 grpc-c/7.0.0 (windows; chttp2; gizmo)'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0418 14:53:48.737944 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\channel\channel_stack.cc:226: OP[connected:000001CE2E5621C0]: SEND_INITIAL_METADATA{key=3a 73 63 68 65 6d 65 ':scheme' value=68 74 74 70 'http', key=3a 6d 65 74 68 6f 64 ':method' value=50 4f 53 54 'POST', key=3a 61 75 74 68 6f 72 69 74 79 ':authority' value=31 32 37 2e 30 2e 30 2e 31 3a 35 30 30 35 31 '127.0.0.1:50051', key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello', key=74 65 'te' value=74 72 61 69 6c 65 72 73 'trailers', key=63 6f 6e 74 65 6e 74 2d 74 79 70 65 'content-type' value=61 70 70 6c 69 63 61 74 69 6f 6e 2f 67 72 70 63 'application/grpc', key=75 73 65 72 2d 61 67 65 6e 74 'user-agent' value=67 72 70 63 2d 63 73 68 61 72 70 2f 31 2e 31 37 2e 30 20 67 72 70 63 2d 63 2f 37 2e 30 2e 30 20 28 77 69 6e 64 6f 77 73 3b 20 63 68 74 74 70 32 3b 20 67 69 7a 6d 6f 29 'grpc-csharp/1.17.0 grpc-c/7.0.0 (windows; chttp2; gizmo)', key=67 72 70 63 2d 61 63 63 65 70 74 2d 65 6e 63 6f 64 69 6e 67 'grpc-accept-encoding' value=69 64 65 6e 74 69 74 79 2c 64 65 66 6c 61 74 65 2c 67 7a 69 70 'identity,deflate,gzip', key=61 63 63 65 70 74 2d 65 6e 63 6f 64 69 6e 67 'accept-encoding' value=69 64 65 6e 74 69 74 79 2c 67 7a 69 70 'identity,gzip'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0418 14:53:48.742059 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1702: perform_stream_op[s=000001CE2E562B98]: SEND_INITIAL_METADATA{key=3a 73 63 68 65 6d 65 ':scheme' value=68 74 74 70 'http', key=3a 6d 65 74 68 6f 64 ':method' value=50 4f 53 54 'POST', key=3a 61 75 74 68 6f 72 69 74 79 ':authority' value=31 32 37 2e 30 2e 30 2e 31 3a 35 30 30 35 31 '127.0.0.1:50051', key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello', key=74 65 'te' value=74 72 61 69 6c 65 72 73 'trailers', key=63 6f 6e 74 65 6e 74 2d 74 79 70 65 'content-type' value=61 70 70 6c 69 63 61 74 69 6f 6e 2f 67 72 70 63 'application/grpc', key=75 73 65 72 2d 61 67 65 6e 74 'user-agent' value=67 72 70 63 2d 63 73 68 61 72 70 2f 31 2e 31 37 2e 30 20 67 72 70 63 2d 63 2f 37 2e 30 2e 30 20 28 77 69 6e 64 6f 77 73 3b 20 63 68 74 74 70 32 3b 20 67 69 7a 6d 6f 29 'grpc-csharp/1.17.0 grpc-c/7.0.0 (windows; chttp2; gizmo)', key=67 72 70 63 2d 61 63 63 65 70 74 2d 65 6e 63 6f 64 69 6e 67 'grpc-accept-encoding' value=69 64 65 6e 74 69 74 79 2c 64 65 66 6c 61 74 65 2c 67 7a 69 70 'identity,deflate,gzip', key=61 63 63 65 70 74 2d 65 6e 63 6f 64 69 6e 67 'accept-encoding' value=69 64 65 6e 74 69 74 79 2c 67 7a 69 70 'identity,gzip'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0418 14:53:48.744867 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:106: ==> grpc_call_combiner_stop() [000001CE15AAF040] [passed batch to transport]
I0418 14:53:48.746764 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:113: size: 1 -> 0
I0418 14:53:48.748810 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:141: queue empty
I0418 14:53:48.749203 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1398: perform_stream_op_locked: SEND_INITIAL_METADATA{key=3a 73 63 68 65 6d 65 ':scheme' value=68 74 74 70 'http', key=3a 6d 65 74 68 6f 64 ':method' value=50 4f 53 54 'POST', key=3a 61 75 74 68 6f 72 69 74 79 ':authority' value=31 32 37 2e 30 2e 30 2e 31 3a 35 30 30 35 31 '127.0.0.1:50051', key=3a 70 61 74 68 ':path' value=2f 68 65 6c 6c 6f 77 6f 72 6c 64 2e 47 72 65 65 74 65 72 2f 53 61 79 48 65 6c 6c 6f '/helloworld.Greeter/SayHello', key=74 65 'te' value=74 72 61 69 6c 65 72 73 'trailers', key=63 6f 6e 74 65 6e 74 2d 74 79 70 65 'content-type' value=61 70 70 6c 69 63 61 74 69 6f 6e 2f 67 72 70 63 'application/grpc', key=75 73 65 72 2d 61 67 65 6e 74 'user-agent' value=67 72 70 63 2d 63 73 68 61 72 70 2f 31 2e 31 37 2e 30 20 67 72 70 63 2d 63 2f 37 2e 30 2e 30 20 28 77 69 6e 64 6f 77 73 3b 20 63 68 74 74 70 32 3b 20 67 69 7a 6d 6f 29 'grpc-csharp/1.17.0 grpc-c/7.0.0 (windows; chttp2; gizmo)', key=67 72 70 63 2d 61 63 63 65 70 74 2d 65 6e 63 6f 64 69 6e 67 'grpc-accept-encoding' value=69 64 65 6e 74 69 74 79 2c 64 65 66 6c 61 74 65 2c 67 7a 69 70 'identity,deflate,gzip', key=61 63 63 65 70 74 2d 65 6e 63 6f 64 69 6e 67 'accept-encoding' value=69 64 65 6e 74 69 74 79 2c 67 7a 69 70 'identity,gzip'} SEND_MESSAGE:flags=0x00000000:len=5 SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA; on_complete = 000001CE2E562958
I0418 14:53:48.756440 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: :scheme: http
I0418 14:53:48.757235 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: :method: POST
I0418 14:53:48.758119 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: :authority: 127.0.0.1:50051
I0418 14:53:48.758674 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: :path: /helloworld.Greeter/SayHello
I0418 14:53:48.759191 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: te: trailers
I0418 14:53:48.760959 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: content-type: application/grpc
I0418 14:53:48.769401 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: user-agent: grpc-csharp/1.17.0 grpc-c/7.0.0 (windows; chttp2; gizmo)
I0418 14:53:48.770826 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: grpc-accept-encoding: identity,deflate,gzip
I0418 14:53:48.772287 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1376: HTTP:0:HDR:CLI: accept-encoding: identity,gzip
I0418 14:53:48.773332 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\stream_lists.cc:125: 000001CE15ABC980[0][cli]: add to waiting_for_concurrency
I0418 14:53:48.774386 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\stream_lists.cc:71: 000001CE15ABC980[0][cli]: pop from waiting_for_concurrency
I0418 14:53:48.775763 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1187: HTTP:CLI: Allocating new grpc_chttp2_stream 000001CE2E562B98 to id 1
I0418 14:53:48.776088 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\stream_lists.cc:125: 000001CE15ABC980[1][cli]: add to writable
I0418 14:53:48.776706 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state IDLE -> WRITING [START_NEW_STREAM]
I0418 14:53:48.777146 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING -> WRITING+MORE [SEND_MESSAGE]
D0418 14:53:48.777456 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\flow_control.cc:113: 000001CE15ABDFC8[1][cli] | app st recv | trw: 65535, ttw: 4194304, taw: 4194304, srw: 65535, slw: 4194304 -> 4194309, saw: 4194304
I0418 14:53:48.778864 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1249: complete_closure_step: t=000001CE15ABC980 000001CE2E562958 refs=3 flags=0x0001 desc=op->on_complete err="No Error" write_state=WRITING+MORE
I0418 14:53:48.783475 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\stream_lists.cc:71: 000001CE15ABC980[1][cli]: pop from writable
I0418 14:53:48.784188 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\writing.cc:413: W:000001CE15ABC980 CLIENT[1] im-(sent,send)=(0,1) announce=5
I0418 14:53:48.784482 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\hpack_encoder.cc:473: Encode: ':authority: 127.0.0.1:50051', elem_interned=1 [1], k_interned=1, v_interned=1
I0418 14:53:48.784760 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\hpack_encoder.cc:473: Encode: ':path: /helloworld.Greeter/SayHello', elem_interned=0 [2], k_interned=1, v_interned=0
I0418 14:53:48.785061 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\hpack_encoder.cc:473: Encode: 'te: trailers', elem_interned=1 [3], k_interned=1, v_interned=1
I0418 14:53:48.785586 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\hpack_encoder.cc:473: Encode: 'content-type: application/grpc', elem_interned=1 [3], k_interned=1, v_interned=1
I0418 14:53:48.785901 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\hpack_encoder.cc:473: Encode: 'user-agent: grpc-csharp/1.17.0 grpc-c/7.0.0 (windows; chttp2; gizmo)', elem_interned=1 [1], k_interned=1, v_interned=1
I0418 14:53:48.786552 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\hpack_encoder.cc:473: Encode: 'grpc-accept-encoding: identity,deflate,gzip', elem_interned=1 [3], k_interned=1, v_interned=1
I0418 14:53:48.786978 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\hpack_encoder.cc:473: Encode: 'accept-encoding: identity,gzip', elem_interned=1 [3], k_interned=1, v_interned=1
I0418 14:53:48.787302 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1249: complete_closure_step: t=000001CE15ABC980 000001CE2E562958 refs=2 flags=0x0001 desc=send_initial_metadata_finished err="No Error" write_state=WRITING+MORE
D0418 14:53:48.787924 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\flow_control.cc:113: 000001CE15ABDFC8[1][cli] | s updt sent | trw: 65535, ttw: 4194304 -> 4194309, taw: 4194304, srw: 65535, slw: 4194309, saw: 4194304 -> 4194309
D0418 14:53:48.788450 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\flow_control.cc:113: 000001CE15ABDFC8[1][cli] | data sent | trw: 65535 -> 65525, ttw: 4194309, taw: 4194304, srw: 65535 -> 65525, slw: 4194309, saw: 4194309
I0418 14:53:48.788937 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1249: complete_closure_step: t=000001CE15ABC980 000001CE2E562958 refs=1 flags=0x0001 desc=send_trailing_metadata_finished err="No Error" write_state=WRITING+MORE
I0418 14:53:48.789376 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:1249: complete_closure_step: t=000001CE15ABC980 000001CE2E562958 refs=0 flags=0x0001 desc=on_write_finished_cb err="No Error" write_state=WRITING+MORE
I0418 14:53:48.789792 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\stream_lists.cc:125: 000001CE15ABC980[1][cli]: add to writing
D0418 14:53:48.790041 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\flow_control.cc:113: 000001CE15ABDFC8[0][cli] | t updt sent | trw: 65525, ttw: 4194309, taw: 4194304 -> 4194309, srw: , slw: , saw:
I0418 14:53:48.790450 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING+MORE -> WRITING [begin write in current thread]
I0418 14:53:48.790916 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING -> WRITING+MORE [RST_STREAM]
I0418 14:53:48.793170 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:69: ==> grpc_call_combiner_start() [000001CE15AAF040] closure=000001CE2E562220 [recv_message_ready] error="No Error"
I0418 14:53:48.793456 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:78: size: 0 -> 1
I0418 14:53:48.793698 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:87: EXECUTING IMMEDIATELY
I0418 14:53:48.793958 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:69: ==> grpc_call_combiner_start() [000001CE15AAF040] closure=000001CE2E5623B8 [recv_trailing_metadata_ready] error="No Error"
I0418 14:53:48.794207 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:78: size: 1 -> 2
I0418 14:53:48.794436 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:93: QUEUING
I0418 14:53:48.794783 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:69: ==> grpc_call_combiner_start() [000001CE15AAF040] closure=000001CE2E562380 [recv_initial_metadata_ready] error="No Error"
I0418 14:53:48.795478 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:78: size: 2 -> 3
I0418 14:53:48.795733 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:93: QUEUING
I0418 14:53:48.796058 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING+MORE -> WRITING [continue writing]
I0418 14:53:48.796347 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\stream_lists.cc:71: 000001CE15ABC980[1][cli]: pop from writing
I0418 14:53:48.796599 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:106: ==> grpc_call_combiner_stop() [000001CE15AAF040] [recv_message_ready]
I0418 14:53:48.796909 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:113: size: 3 -> 2
I0418 14:53:48.797309 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:120: checking queue
I0418 14:53:48.797589 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:134: EXECUTING FROM QUEUE: closure=000001CE2E5623B8 error="No Error"
I0418 14:53:48.797833 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:106: ==> grpc_call_combiner_stop() [000001CE15AAF040] [deferring recv_trailing_metadata_ready until after recv_initial_metadata_ready]
I0418 14:53:48.798106 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:113: size: 2 -> 1
I0418 14:53:48.798345 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:120: checking queue
I0418 14:53:48.798597 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:134: EXECUTING FROM QUEUE: closure=000001CE2E562380 error="No Error"
I0418 14:53:48.798845 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:69: ==> grpc_call_combiner_start() [000001CE15AAF040] closure=000001CE2E5623B8 [continue recv_trailing_metadata] error="No Error"
I0418 14:53:48.799088 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:78: size: 1 -> 2
I0418 14:53:48.799328 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:93: QUEUING
I0418 14:53:48.799565 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:106: ==> grpc_call_combiner_stop() [000001CE15AAF040] [recv_initial_metadata_ready]
I0418 14:53:48.799802 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:113: size: 2 -> 1
I0418 14:53:48.800087 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:120: checking queue
I0418 14:53:48.800330 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:134: EXECUTING FROM QUEUE: closure=000001CE2E5623B8 error="No Error"
I0418 14:53:48.800580 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:106: ==> grpc_call_combiner_stop() [000001CE15AAF040] [recv_trailing_metadata_ready]
I0418 14:53:48.800809 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:113: size: 1 -> 0
I0418 14:53:48.801047 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:141: queue empty
D0418 14:53:48.801298 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:719: set_final_status CLI
D0418 14:53:48.801545 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:720: {"created":"@1555592028.801000000","description":"Error received from peer","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc","file_line":1036,"grpc_message":"Stream removed","grpc_status":2}
I0418 14:53:48.802018 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:2609: ipv4:10.240.240.1:8080: Complete BDP ping err={"created":"@1555592028.790000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053}
D0418 14:53:48.804257 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\flow_control.cc:113: 000001CE15ABDFC8[0][cli] | t updt sent | trw: 65525, ttw: 4194309, taw: 4194309, srw: , slw: , saw:
I0418 14:53:48.804855 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING -> WRITING [begin write in background]
I0418 14:53:48.805188 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:243: EXECUTOR (default-executor) try to schedule 000001CE15ABCA70 (short) to thread 0
I0418 14:53:48.808605 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:188: EXECUTOR (default-executor) [0]: execute
I0418 14:53:48.808894 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:73: EXECUTOR (default-executor) run 000001CE15ABCA70
I0418 14:53:48.809519 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:852: W:000001CE15ABC980 CLIENT state WRITING -> IDLE [finish writing]
I0418 14:53:48.809740 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc:2790: set connectivity_state=4
I0418 14:53:48.810045 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15ABCC28 client_transport: READY --> SHUTDOWN [close_transport] error=000001CE1412BA10 {"created":"@1555592028.796000000","description":"Delayed close due to in-progress write","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":609,"referenced_errors":[{"created":"@1555592028.790000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053},{"created":"@1555592028.805000000","description":"Endpoint read failed","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":2510,"grpc_status":14,"occurred_during_write":1,"referenced_errors":[{"created":"@1555592028.805000000","description":"End of TCP stream","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":202}]},{"created":"@1555592028.809000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053}]}
I0418 14:53:48.812157 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:190: NOTIFY: 000001CE15ABCC28 client_transport: 000001CE15A57F08
I0418 14:53:48.812455 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:69: ==> grpc_call_combiner_start() [000001CE15AAF040] closure=000001CE15AAFF70 [on_complete] error="No Error"
I0418 14:53:48.812672 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:78: size: 0 -> 1
I0418 14:53:48.815261 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:87: EXECUTING IMMEDIATELY
I0418 14:53:48.815555 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A5ABC0 subchannel: READY --> TRANSIENT_FAILURE [reflect_child] error=000001CE1412BA10 {"created":"@1555592028.796000000","description":"Delayed close due to in-progress write","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":609,"referenced_errors":[{"created":"@1555592028.790000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053},{"created":"@1555592028.805000000","description":"Endpoint read failed","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":2510,"grpc_status":14,"occurred_during_write":1,"referenced_errors":[{"created":"@1555592028.805000000","description":"End of TCP stream","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":202}]},{"created":"@1555592028.809000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053}]}
I0418 14:53:48.817336 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:190: NOTIFY: 000001CE15A5ABC0 subchannel: 000001CE159FCEF8
I0418 14:53:48.817581 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A5ABE0 subchannel: READY --> TRANSIENT_FAILURE [reflect_child] error=000001CE1412BA10 {"created":"@1555592028.796000000","description":"Delayed close due to in-progress write","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":609,"referenced_errors":[{"created":"@1555592028.790000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053},{"created":"@1555592028.805000000","description":"Endpoint read failed","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":2510,"grpc_status":14,"occurred_during_write":1,"referenced_errors":[{"created":"@1555592028.805000000","description":"End of TCP stream","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":202}]},{"created":"@1555592028.809000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053}]}
I0418 14:53:48.822406 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:106: ==> grpc_call_combiner_stop() [000001CE15AAF040] [on_complete]
I0418 14:53:48.822827 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:113: size: 1 -> 0
I0418 14:53:48.823290 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:141: queue empty
I0418 14:53:48.823650 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:782: cq_end_op_for_pluck(cq=000001CE15A69840, tag=000001CE15A44E40, error="No Error", done=00007FFA8B144040, done_arg=000001CE15AAFED0, storage=000001CE15AAFF20)
I0418 14:53:48.828827 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\resource_quota.cc:544: RU shutdown 000001CE15AB9420
I0418 14:53:48.828827 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:1299: RETURN_EVENT[000001CE15A69840]: OP_COMPLETE: tag:000001CE15A44E40 OK
I0418 14:53:48.829695 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:447: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0 of 1 (subchannel 000001CE15A5AAD0): connectivity changed: state=TRANSIENT_FAILURE, error={"created":"@1555592028.796000000","description":"Delayed close due to in-progress write","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":609,"referenced_errors":[{"created":"@1555592028.790000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053},{"created":"@1555592028.805000000","description":"Endpoint read failed","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":2510,"grpc_status":14,"occurred_during_write":1,"referenced_errors":[{"created":"@1555592028.805000000","description":"End of TCP stream","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":202}]},{"created":"@1555592028.809000000","description":"OS Error","file":"T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\tcp_windows.cc","file_line":344,"grpc_status":14,"os_error":"An established connection was aborted by the software in your host machine.\r\n","syscall":"WSASend","wsa_error":10053}]}, shutting_down=0
I0418 14:53:48.833412 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\lb_policy\pick_first\pick_first.cc:461: Pick First 000001CE15AB44A0 connectivity changed for selected subchannel
I0418 14:53:48.833677 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15AB45D0 pick_first: READY --> IDLE [selected_changed+reresolve] error=0000000000000000 "No Error"
I0418 14:53:48.833964 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:190: NOTIFY: 000001CE15AB45D0 pick_first: 000001CE15A3F288
I0418 14:53:48.834296 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\lb_policy.cc:47: pick_first 000001CE15AB44A0: scheduling re-resolution closure with error="No Error".
I0418 14:53:48.834604 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src/core/ext/filters/client_channel/lb_policy/subchannel_list.h:374: [pick_first 000001CE15AB44A0] subchannel list 000001CE15AB7AA0 index 0 of 1 (subchannel 000001CE15A5AAD0): stopping connectivity watch
I0418 14:53:48.835207 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:214: chand=000001CE15A237B0: lb_policy=000001CE15AB44A0 state changed to IDLE
I0418 14:53:48.835450 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:196: chand=000001CE15A237B0: setting connectivity state to IDLE
I0418 14:53:48.836253 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:164: SET: 000001CE15A23838 client_channel: READY --> IDLE [lb_changed] error=0000000000000000 "No Error"
I0418 14:53:48.836611 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\transport\connectivity_state.cc:116: CONWATCH: 000001CE15AB45D0 pick_first: from IDLE [cur=IDLE] notify=000001CE15A3F698
I0418 14:53:48.836969 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\client_channel.cc:306: chand=000001CE15A237B0: started name re-resolving
D0418 14:53:48.837251 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\ext\filters\client_channel\resolver\dns\native\dns_resolver.cc:259: In cooldown from last resolution (from 169 ms ago). Will resolve again in 831 ms
I0418 14:53:48.837491 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\call.cc:561: grpc_call_unref(c=000001CE15AAF030)
I0418 14:53:48.839514 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:365: TIMER 000001CE15A0D0D0: SET 831 now 305 call 000001CE15A0D100[00007FFA8B1A5BE0]
I0418 14:53:48.839766 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:167: call_combiner=000001CE15AAF040: setting notify_on_cancel=0000000000000000
I0418 14:53:48.840008 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:401: .. add to shard 6 with queue_deadline_cap=1003 => is_first_timer=true
I0418 14:53:48.840284 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\call_combiner.cc:176: call_combiner=000001CE15AAF040: scheduling old cancel callback=000001CE15AAFB98
I0418 14:53:48.840545 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:423: .. old shard min_deadline=1004
I0418 14:53:48.841037 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_manager.cc:200: wait ended: was_timed:0 kicked:1
I0418 14:53:48.841066 1984612413504 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\executor.cc:167: EXECUTOR (default-executor) [0]: step (sub_depth=1)
I0418 14:53:48.841281 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:715: TIMER CHECK BEGIN: now=333 next=9223372036854775807 tls_min=0 glob_min=831
I0418 14:53:48.841776 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_generic.cc:738: TIMER CHECK END: r=1; next=831
I0418 14:53:48.842049 1984612413984 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\iomgr\timer_manager.cc:185: sleep for a 498 milliseconds
I0418 14:53:48.862293 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:1395: grpc_completion_queue_destroy(cq=000001CE15A69840)
I0418 14:53:48.862455 0 T:\src\github\grpc\workspace_csharp_ext_windows_x64\src\core\lib\surface\completion_queue.cc:1389: grpc_completion_queue_shutdown(cq=000001CE15A69840)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment