Name resolution in C# / grpclb selection

42 views
Skip to first unread message

Benjamin Krämer

unread,
Sep 1, 2020, 10:20:05 AM9/1/20
to grpc.io

I had the problem already some years ago (https://github.com/grpc/grpc/issues/11879). In the meantime, we helped us out by using grpclb for name resolution purposes. We also discussed about other solutions: https://github.com/grpc/grpc/pull/13639

There also is the long plan to have a public resolver API discussed in here https://github.com/grpc/grpc/pull/16617

Sadly for us, grpclb does not seem to be selected by default anymore in favor of xDS and therefore now broke our code base. I have also not found a way to set the service config in C# to select the grpclb LB policy directly. Can anyone point me into the direction of how to set it in C#? I assume there's a channel option?

I would like to avoid having to change our workaround from grpclb to xDS and hope that there will be some progress on the public resolver API instead.

Benjamin Krämer

unread,
Sep 1, 2020, 10:28:23 AM9/1/20
to grpc.io
I did this using C# gRPC lib 2.31.0:
GRPC_VERBOSITY=DEBUG
GRPC_TRACE=cares_resolver,cares_address_sorting,client_channel_call,client_channel_routing,connectivity_state,glb

In the past, once AAAA and A DNS requests failed, it tried SRV request. The DNS server to use is 127.0.0.1:8010 and the channel target is dns://127.0.0.1:8010/test.my-company.com

D0901 16:23:59.208158 Grpc.Core.Internal.UnmanagedLibrary Attempting to load native library "C:\Users\dejhbk0l\.nuget\packages\grpc.core\2.31.0\lib\netstandard2.0\../..\runtimes/win/native\grpc_csharp_ext.x64.dll"
D0901 16:24:00.789720 Grpc.Core.Internal.NativeExtension gRPC native library loaded successfully.
D0901 16:24:00.878653 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "grpclb"
D0901 16:24:00.878794 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "cds_experimental"
D0901 16:24:00.878862 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "eds_experimental"
D0901 16:24:00.878925 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "lrs_experimental"
D0901 16:24:00.959562 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "priority_experimental"
D0901 16:24:00.959713 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "weighted_target_experimental"
D0901 16:24:00.959782 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "xds_routing_experimental"
D0901 16:24:00.959896 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "pick_first"
D0901 16:24:00.960031 0 X:\ext\filters\client_channel\lb_policy_registry.cc:40: registering LB policy factory for "round_robin"
D0901 16:24:00.960121 0 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:507: Using ares dns resolver
I0901 16:24:01.465804 0 X:\ext\filters\client_channel\client_channel.cc:1633: chand=0000013FFC8CB7B0: creating client_channel for channel stack 0000013FFC8CB740
I0901 16:24:01.932559 0 X:\ext\filters\client_channel\client_channel.cc:2410: chand=0000013FFC8CB7B0 calld=0000013FFC323830: adding pending batch at index 0
I0901 16:24:01.932604 0 X:\ext\filters\client_channel\client_channel.cc:2215: chand=0000013FFC8CB7B0 calld=0000013FFC323830: grabbing data plane mutex to perform pick
I0901 16:24:01.932626 0 X:\ext\filters\client_channel\client_channel.cc:3862: chand=0000013FFC8CB7B0 calld=0000013FFC323830: adding to queued picks list
I0901 16:24:01.932711 0 X:\lib\transport\connectivity_state.cc:174: ConnectivityStateTracker client_channel[0000013FFC8CB898]: get current state: IDLE
I0901 16:24:01.932833 0 X:\ext\filters\client_channel\resolving_lb_policy.cc:161: resolving_lb=0000013FFC8FFC50: starting name resolution
I0901 16:24:01.932856 0 X:\ext\filters\client_channel\client_channel.cc:1362: chand=0000013FFC8CB7B0: update: state=CONNECTING picker=0000013FFC5C5690
I0901 16:24:01.932876 0 X:\lib\transport\connectivity_state.cc:152: ConnectivityStateTracker client_channel[0000013FFC8CB898]: IDLE -> CONNECTING (helper)
D0901 16:24:01.932976 0 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:185: (c-ares resolver) resolver:0000013FFC550E30 AresDnsResolver::StartLocked() is called.
D0901 16:24:01.933042 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:648: (c-ares resolver) request:0000013FFC83B360 c-ares grpc_dns_lookup_ares_locked_impl name=test.my-company.com, default_port=https
D0901 16:24:01.949066 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:158: (c-ares resolver) request:0000013FFC83B360 grpc_ares_ev_driver_create_locked
D0901 16:24:01.949153 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:429: (c-ares resolver) request:0000013FFC83B360 Using DNS server 127.0.0.1:8010
D0901 16:24:01.950533 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:203: (c-ares resolver) request:0000013FFC83B360 create_hostbyname_request_locked host:test.my-company.com port:47873 is_balancer:0 qtype:AAAA
D0901 16:24:16.105766 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:766: (c-ares resolver) fd:|c-ares socket: 1064| created with params af:2 type:2 protocol:0
D0901 16:24:16.105812 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:490: (c-ares resolver) fd:c-ares socket: 1064 ConnectUDP
D0901 16:24:16.108783 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:501: (c-ares resolver) fd:c-ares socket: 1064 WSAConnect error code:|0| msg:|The operation completed successfully.
|
D0901 16:24:16.108863 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:16.108893 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:16.109676 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:43 *bytes_sent_ptr:43 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:16.109782 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:203: (c-ares resolver) request:0000013FFC83B360 create_hostbyname_request_locked host:test.my-company.com port:47873 is_balancer:0 qtype:A
D0901 16:24:31.355947 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.355996 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.356198 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:43 *bytes_sent_ptr:43 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.356259 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:393: (c-ares resolver) request:0000013FFC83B360 new fd: c-ares socket: 1064
D0901 16:24:31.356290 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.356315 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.356354 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:466: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 grpc_ares_ev_driver_start_locked. timeout in 121138 ms
D0901 16:24:31.356383 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.356406 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.356544 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.356594 0 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:449: (c-ares resolver) resolver:0000013FFC550E30 Started resolving. pending_request_:0000013FFC83B360
I0901 16:24:31.356635 0 X:\ext\filters\client_channel\client_channel.cc:1865: chand=0000013FFC8CB7B0: created resolving_lb_policy=0000013FFC8FFC50
D0901 16:24:31.356658 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.356725 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.356748 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.356777 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|4192|
D0901 16:24:31.356803 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.356822 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.356945 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:43 *bytes_sent_ptr:43 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.356971 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.357030 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357057 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357078 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|43|
D0901 16:24:31.357100 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.357169 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.357193 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|43|
D0901 16:24:31.357220 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.357238 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.357364 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:69 *bytes_sent_ptr:69 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.357392 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.357414 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.357433 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357462 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357492 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.357513 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.357537 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.357557 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.357584 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357609 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357658 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.357680 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.357708 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.357729 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.357751 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357776 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357805 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.357827 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.357849 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.357870 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.357896 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357921 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.357946 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.357966 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.357986 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.358088 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.358110 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.358136 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.358159 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.358196 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.358218 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.358239 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.358258 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.358300 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.358333 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.358359 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.358379 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.358410 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.358430 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.358454 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.358499 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.358751 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.358806 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.358913 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.358938 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.358966 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.359093 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.359127 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.359219 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.359717 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.359848 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.360014 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.360129 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.360152 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.360187 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.360334 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.360447 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.360643 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.360781 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.360819 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.360843 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.360867 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.360889 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.361071 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.361102 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.361124 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.361145 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.361179 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.361200 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.361357 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.361382 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.361458 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.361482 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.361526 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.361564 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.361954 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.362136 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.362172 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.362207 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.362237 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.362293 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.362328 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.362484 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.362516 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.362546 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.362569 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.362746 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.362908 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.363000 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.363034 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.363068 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.363098 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.363124 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.363258 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.363302 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.363331 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.363446 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.363532 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.363557 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364145 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364184 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.364303 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.364337 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.364361 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.364382 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364456 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364503 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.364534 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.364569 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.364606 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.364634 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364669 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364703 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.364731 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.364766 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.364797 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.364860 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364895 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.364933 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.364962 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.364993 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.365023 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.365056 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365089 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365122 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.365146 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.365176 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.365236 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.365281 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365388 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365413 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.365492 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.365515 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.365536 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.365556 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365660 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365688 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.365707 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.365733 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.365773 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.365801 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365893 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.365919 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.365949 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.365980 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.366001 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.366050 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366143 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366178 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.366206 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.366230 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.366252 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.366304 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366403 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366432 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.366454 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.366497 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.366524 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.366544 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366568 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366659 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.366723 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.366744 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.366763 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.366783 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366899 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.366929 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.366949 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.366969 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.367050 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.367083 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.367183 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.367219 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.367254 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.367367 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.367393 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.367467 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.367498 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.367529 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.367550 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.367573 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.367592 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.367623 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.367644 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.368342 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:185: (c-ares resolver) fd:|c-ares socket: 1064| RegisterForOnReadableLocked WSARecvFrom error code:|997| msg:|Overlapped I/O operation is in progress.
|
D0901 16:24:31.368381 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.368414 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.368440 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|4192|
D0901 16:24:31.368465 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.368486 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.368515 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.368573 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.368644 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.368677 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|4192|
D0901 16:24:31.368707 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.368759 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.368795 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.368827 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.368856 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.368905 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|4192|
D0901 16:24:31.368944 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.368970 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.368999 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.369028 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.369044 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.369060 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|4192|
D0901 16:24:31.369080 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.369248 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.369289 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.369309 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.369325 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.369343 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|4192|
D0901 16:24:31.369392 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.369410 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.369439 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.384522 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=0. err="No Error"
D0901 16:24:31.384603 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:284: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked; ares_process_fd. fd=c-ares socket: 1064
D0901 16:24:31.384645 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|4192|
D0901 16:24:31.384682 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:230: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0. next ares process poll time in 1000 ms
D0901 16:24:31.384704 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.384728 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.384752 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|43|
D0901 16:24:31.384841 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.384866 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|43|
D0901 16:24:31.384898 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.384920 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.385157 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:69 *bytes_sent_ptr:69 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.385200 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.385224 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.385286 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.385314 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.385335 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.386190 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|43|
D0901 16:24:31.386250 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.386284 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|43|
D0901 16:24:31.386321 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.386343 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.386419 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.386448 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.386471 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.386674 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|69|
D0901 16:24:31.386709 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.386750 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|69|
D0901 16:24:31.386793 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.386817 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.387015 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:60 *bytes_sent_ptr:60 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.387056 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.387088 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.387118 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.387151 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.387176 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.387230 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|69|
D0901 16:24:31.387248 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.387329 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|69|
D0901 16:24:31.387360 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.387391 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.387467 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:60 *bytes_sent_ptr:60 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.387499 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.387523 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.387546 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.387580 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.387608 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.387648 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|60|
D0901 16:24:31.387665 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.387720 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|60|
D0901 16:24:31.387754 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.387774 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.387891 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:56 *bytes_sent_ptr:56 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.387928 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.387987 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.388009 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.388035 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.388060 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.388116 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|60|
D0901 16:24:31.388143 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.388164 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|60|
D0901 16:24:31.388187 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.388214 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.388391 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:56 *bytes_sent_ptr:56 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.388429 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.388463 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.388496 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.388530 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.388550 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.388589 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|56|
D0901 16:24:31.388654 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.388688 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|56|
D0901 16:24:31.388714 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.388733 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.388853 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:69 *bytes_sent_ptr:69 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.388885 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.388906 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.388925 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.388950 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.388971 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.389029 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:185: (c-ares resolver) fd:|c-ares socket: 1064| RegisterForOnReadableLocked WSARecvFrom error code:|997| msg:|Overlapped I/O operation is in progress.
|
D0901 16:24:31.454408 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|56|
D0901 16:24:31.454459 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.454492 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|56|
D0901 16:24:31.454571 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.454665 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.454877 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:69 *bytes_sent_ptr:69 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.454901 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.454929 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.454955 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.454979 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.454997 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.455042 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|69|
D0901 16:24:31.455075 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.455097 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|69|
D0901 16:24:31.455128 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.455149 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.455329 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:63 *bytes_sent_ptr:63 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.455360 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.455385 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.455407 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.455474 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.455515 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.455562 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|69|
D0901 16:24:31.455586 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.455615 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|69|
D0901 16:24:31.455680 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.455705 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.455851 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:63 *bytes_sent_ptr:63 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.455881 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.455902 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.455933 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.455957 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.455984 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.456025 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|63|
D0901 16:24:31.456066 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.456100 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|63|
D0901 16:24:31.456175 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.456198 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.456346 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:56 *bytes_sent_ptr:56 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.456377 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.456404 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.456426 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.456451 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.456483 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.456535 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|63|
D0901 16:24:31.456568 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.456595 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|63|
D0901 16:24:31.456633 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:334: (c-ares resolver) fd:|c-ares socket: 1064| SendV called connect_done_:1 wsa_connect_error_:0
D0901 16:24:31.456660 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:358: (c-ares resolver) fd:|c-ares socket: 1064| SendVUDP called
D0901 16:24:31.456786 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:326: (c-ares resolver) fd:|c-ares socket: 1064| SendWriteBuf WSASend buf.len:56 *bytes_sent_ptr:56 overlapped:0000000000000000 return:0 *wsa_error_code:0
D0901 16:24:31.456815 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.456837 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.456909 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.456936 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.456959 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.457008 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|56|
D0901 16:24:31.457052 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.457078 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|56|
D0901 16:24:31.457150 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:286: (c-ares resolver) request:0000013FFC83B360 on_hostbyname_done_locked: C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data
D0901 16:24:31.457200 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.457219 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:99: (c-ares resolver) request:0000013FFC83B360 Ref ev_driver 0000013FFC4F43D0
D0901 16:24:31.457236 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:408: (c-ares resolver) request:0000013FFC83B360 notify read on: c-ares socket: 1064
D0901 16:24:31.457255 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.457289 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:164: (c-ares resolver) fd:|c-ares socket: 1064| InnerContinueRegisterForOnReadableLocked wsa_connect_error_:0
D0901 16:24:31.457328 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:618: (c-ares resolver) fd:|c-ares socket: 1064| OnIocpReadable finishing. read buf length now:|56|
D0901 16:24:31.457344 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:313: (c-ares resolver) request:0000013FFC83B360 readable on c-ares socket: 1064
D0901 16:24:31.457359 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:1 Current read buf length:|56|
D0901 16:24:31.457415 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:286: (c-ares resolver) request:0000013FFC83B360 on_hostbyname_done_locked: C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data
D0901 16:24:31.457449 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.457470 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:272: (c-ares resolver) fd:|c-ares socket: 1064| RecvFrom called read_buf_has_data:0 Current read buf length:|0|
D0901 16:24:31.460392 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:119: (c-ares resolver) request:0000013FFC83B360 delete fd: c-ares socket: 1064
D0901 16:24:31.460766 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:450: (c-ares resolver) request:0000013FFC83B360 ev driver stop working
D0901 16:24:31.461011 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.461053 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:246: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_timeout_locked. driver->shutting_down=1. err="Cancelled"
D0901 16:24:31.461073 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.461102 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:276: (c-ares resolver) request:0000013FFC83B360 ev_driver=0000013FFC4F43D0 on_ares_backup_poll_alarm_locked. driver->shutting_down=1. err="Cancelled"
D0901 16:24:31.461128 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:106: (c-ares resolver) request:0000013FFC83B360 Unref ev_driver 0000013FFC4F43D0
D0901 16:24:31.461148 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:109: (c-ares resolver) request:0000013FFC83B360 destroy ev_driver 0000013FFC4F43D0
D0901 16:24:31.461169 0 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver_windows.cc:805: (c-ares resolver) CloseSocket called for socket: c-ares socket: 1064
D0901 16:24:31.461648 0 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:373: (c-ares resolver) resolver:0000013FFC550E30 dns resolution failed: {"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}
I0901 16:24:31.461975 0 X:\ext\filters\client_channel\resolving_lb_policy.cc:206: resolving_lb=0000013FFC8FFC50: resolver transient failure: {"created":"@1598970271.461000000","description":"DNS resolution failed for service: test.my-company.com","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc","file_line":378,"grpc_status":14,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}]}
I0901 16:24:31.462330 0 X:\ext\filters\client_channel\client_channel.cc:1362: chand=0000013FFC8CB7B0: update: state=TRANSIENT_FAILURE picker=0000013FFC5C55B0
I0901 16:24:31.462397 0 X:\lib\transport\connectivity_state.cc:152: ConnectivityStateTracker client_channel[0000013FFC8CB898]: CONNECTING -> TRANSIENT_FAILURE (helper)
I0901 16:24:31.462453 0 X:\ext\filters\client_channel\client_channel.cc:3849: chand=0000013FFC8CB7B0 calld=0000013FFC323830: removing from queued picks list
D0901 16:24:31.462515 0 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:384: (c-ares resolver) resolver:0000013FFC550E30 dns resolution failed (will retry): {"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}
D0901 16:24:31.462564 0 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:393: (c-ares resolver) resolver:0000013FFC550E30 retrying in 1000 milliseconds
I0901 16:24:31.462655 0 X:\ext\filters\client_channel\client_channel.cc:3795: chand=0000013FFC8CB7B0 calld=0000013FFC323830: failed to pick subchannel: error={"created":"@1598970271.462000000","description":"Resolver transient failure","file":"X:\ext\filters\client_channel\resolving_lb_policy.cc","file_line":214,"referenced_errors":[{"created":"@1598970271.461000000","description":"DNS resolution failed for service: test.my-company.com","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc","file_line":378,"grpc_status":14,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}]}]}
I0901 16:24:31.462764 0 X:\ext\filters\client_channel\client_channel.cc:2520: chand=0000013FFC8CB7B0 calld=0000013FFC323830: failing 1 pending batches: {"created":"@1598970271.462000000","description":"Resolver transient failure","file":"X:\ext\filters\client_channel\resolving_lb_policy.cc","file_line":214,"referenced_errors":[{"created":"@1598970271.461000000","description":"DNS resolution failed for service: test.my-company.com","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc","file_line":378,"grpc_status":14,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}]}]}
I0901 16:24:31.462823 0 X:\ext\filters\client_channel\client_channel.cc:3824: chand=0000013FFC8CB7B0 calld=0000013FFC323830: cancelling queued pick: error={"created":"@1598970271.462000000","description":"Resolver transient failure","file":"X:\ext\filters\client_channel\resolving_lb_policy.cc","file_line":214,"referenced_errors":[{"created":"@1598970271.461000000","description":"DNS resolution failed for service: test.my-company.com","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc","file_line":378,"grpc_status":14,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}]}]} self=0000013FFC916630 calld->pick_canceller=0000000000000000
I0901 16:24:31.463271 0 X:\ext\filters\client_channel\client_channel.cc:2175: chand=0000013FFC8CB7B0 calld=0000013FFC323830: recording cancel_error={"created":"@1598970271.462000000","description":"Resolver transient failure","file":"X:\ext\filters\client_channel\resolving_lb_policy.cc","file_line":214,"referenced_errors":[{"created":"@1598970271.461000000","description":"DNS resolution failed for service: test.my-company.com","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc","file_line":378,"grpc_status":14,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}]}]}
I0901 16:24:31.463420 0 X:\ext\filters\client_channel\client_channel.cc:2520: chand=0000013FFC8CB7B0 calld=0000013FFC323830: failing 0 pending batches: {"created":"@1598970271.462000000","description":"Resolver transient failure","file":"X:\ext\filters\client_channel\resolving_lb_policy.cc","file_line":214,"referenced_errors":[{"created":"@1598970271.461000000","description":"DNS resolution failed for service: test.my-company.com","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc","file_line":378,"grpc_status":14,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=A name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287,"referenced_errors":[{"created":"@1598970271.457000000","description":"C-ares status is not ARES_SUCCESS qtype=AAAA name=test.my-company.com is_balancer=0: DNS server returned answer with no data","file":"X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc","file_line":287}]}]}]}
D0901 16:24:32.467350 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:223: (c-ares resolver) resolver:0000013FFC550E30 re-resolution timer fired. error: "No Error". shutdown_initiated_: 0
D0901 16:24:32.469253 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\dns_resolver_ares.cc:228: (c-ares resolver) resolver:0000013FFC550E30 start resolving due to re-resolution timer
D0901 16:24:32.469329 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:648: (c-ares resolver) request:0000013FFC83C010 c-ares grpc_dns_lookup_ares_locked_impl name=test.my-company.com, default_port=https
D0901 16:24:32.497589 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_ev_driver.cc:158: (c-ares resolver) request:0000013FFC83C010 grpc_ares_ev_driver_create_locked
D0901 16:24:32.497638 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:429: (c-ares resolver) request:0000013FFC83C010 Using DNS server 127.0.0.1:8010
D0901 16:24:32.497670 1374331952816 X:\ext\filters\client_channel\resolver\dns\c_ares\grpc_ares_wrapper.cc:203: (c-ares resolver) request:0000013FFC83C010 create_hostbyname_request_locked host:test.my-company.com port:47873 is_balancer:0 qtype:AAAA

Mark D. Roth

unread,
Sep 1, 2020, 10:51:03 AM9/1/20
to Benjamin Krämer, grpc.io
The grpclb selection logic changed recently.  For details, see https://github.com/grpc/proposal/blob/master/A26-grpclb-selection.md.

In order to select grpclb, you'll need to do two things:

1. Set the GRPC_ARG_DNS_ENABLE_SRV_QUERIES channel arg to 1.  (This has been required since the c-ares based DNS resolver became the default, although it might not have been required in earlier versions if you explicitly enabled the c-ares resolver.)
2. Set a service config that looks something like this:

{
  "loadBalancingConfig":[
    { "grpclb":{} }
  ]
}


There are two ways to inject the service config:
I hope this information is helpful.

--
You received this message because you are subscribed to the Google Groups "grpc.io" group.
To unsubscribe from this group and stop receiving emails from it, send an email to grpc-io+u...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/grpc-io/d732fc23-1f07-4706-9280-f78c97dd7279n%40googlegroups.com.


--
Mark D. Roth <ro...@google.com>
Software Engineer
Google, Inc.

Benjamin Krämer

unread,
Sep 1, 2020, 12:45:47 PM9/1/20
to grpc.io
I finally found some options that bring me the grpclb back. But connecting takes around 15-25 seconds...
```
new ChannelOption("grpc.lb_policy_name", "grpclb"),
new ChannelOption("grpc.service_config", "{\"serviceConfig\":{\"load_balancing_config\":{ \"grpclb\": {} },\"waitForReady\":true}}"),
new ChannelOption("grpc.dns_enable_srv_queries", 1)
```

Benjamin Krämer

unread,
Sep 2, 2020, 2:54:57 AM9/2/20
to grpc.io
@Mark: Thanks for the input, that helped in finding the names (as there are no defines for that in C#).

Made a separate issue for the delays: https://github.com/grpc/grpc/issues/24042
Reply all
Reply to author
Forward
0 new messages