Skip to content

Instantly share code, notes, and snippets.

@JustinBeckwith

JustinBeckwith/proxy.log

Created September 20, 2018 15:15
Show Gist options
  • Save JustinBeckwith/039316dbb54531288371794cdacd4de2 to your computer and use it in GitHub Desktop.
Save JustinBeckwith/039316dbb54531288371794cdacd4de2 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
proxy.log
D0920 16:58:52.869000000 12304 dns_resolver.cc:348] Using native dns resolver
I0920 16:58:52.873000000 12304 timer_manager.cc:85] Spawn timer thread
I0920 16:58:52.891000000 12304 init.cc:153] grpc_init(void)
I0920 16:58:52.900000000 12304 completion_queue.cc:473] grpc_completion_queue_create_internal(completion_type=0, polling_type=0)
I0920 16:58:52.892000000 4892 timer_manager.cc:235] timers not checked: expect another thread to
I0920 16:58:52.965000000 4892 timer_manager.cc:183] sleep until kicked
I0920 16:58:53.113000000 12304 ssl_credentials.cc:128] grpc_ssl_credentials_create(pem_root_certs=(null), pem_key_cert_pair=0000000000000000, verify_options=000000000019D2B8, reserved=0000000000000000)
I0920 16:58:53.148000000 12304 plugin_credentials.cc:263] grpc_metadata_credentials_create_from_plugin(reserved=0000000000000000)
I0920 16:58:53.159000000 12304 composite_credentials.cc:262] grpc_composite_channel_credentials_create(channel_creds=000000000228C110, call_creds=00000000002ED2C0, reserved=0000000000000000)
I0920 16:58:53.169000000 12304 secure_channel_create.cc:208] grpc_secure_channel_create(creds=0000000002BA6BA0, target=dialogflow.googleapis.com:443, args=0000000002BEFA10, reserved=0000000000000000)
I0920 16:58:53.189000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000002222F98 [scheduling deadline timer] error="No Error"
I0920 16:58:53.203000000 12304 call_combiner.cc:76] size: 0 -> 1
I0920 16:58:53.214000000 12304 call_combiner.cc:85] EXECUTING IMMEDIATELY
I0920 16:58:53.217000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [done scheduling deadline timer]
I0920 16:58:53.224000000 12304 call_combiner.cc:111] size: 1 -> 0
I0920 16:58:53.230000000 12304 call_combiner.cc:139] queue empty
I0920 16:58:53.233000000 12304 channel.cc:272] grpc_channel_get_target(channel=000000000221FDD0)
I0920 16:58:53.241000000 12304 metadata_array.cc:29] grpc_metadata_array_init(array=0000000002BA6A88)
I0920 16:58:53.250000000 12304 call.cc:1987] grpc_call_start_batch(call=0000000000372B00, ops=000000000034DDD0, nops=1, tag=0000000002BA6AE0, reserved=0000000000000000)
I0920 16:58:53.259000000 12304 call.cc:1597] ops[0]: SEND_INITIAL_METADATA
key=x-goog-api-client value=67 6c 2d 6e 6f 64 65 2f 76 31 30 2e 31 30 2e 30 20 67 72 70 63 2f 31 2e 31 35 2e 30 20 67 61 78 2f 30 2e 31 37 2e 31 20 67 61 70 69 63 2f 30 2e 36 2e 30 'gl-node/v10.10.0 grpc/1.15.0 gax/0.17.1 gapic/0.6.0'
I0920 16:58:53.278000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=00000000003739F0 [executing batch] error="No Error"
I0920 16:58:53.289000000 12304 call_combiner.cc:76] size: 0 -> 1
I0920 16:58:53.294000000 12304 call_combiner.cc:85] EXECUTING IMMEDIATELY
I0920 16:58:53.300000000 12304 call.cc:642] OP[client-channel:00000000003734A0]: SEND_INITIAL_METADATA{key=3a 70 61 74 68 ':path' value=2f 67 6f 6f 67 6c 65 2e 63 6c 6f 75 64 2e 64 69 61 6c 6f 67 66 6c 6f 77 2e 76 32 2e 53 65 73 73 69 6f 6e 73 2f 44 65 74 65 63 74 49 6e 74 65 6e 74 '/google.cloud.dialogflow.v2.Sessions/DetectIntent', key=78 2d 67 6f 6f 67 2d 61 70 69 2d 63 6c 69 65 6e 74 'x-goog-api-client' value=67 6c 2d 6e 6f 64 65 2f 76 31 30 2e 31 30 2e 30 20 67 72 70 63 2f 31 2e 31 35 2e 30 20 67 61 78 2f 30 2e 31 37 2e 31 20 67 61 70 69 63 2f 30 2e 36 2e 30 'gl-node/v10.10.0 grpc/1.15.0 gax/0.17.1 gapic/0.6.0' deadline=220316}
I0920 16:58:53.341000000 12304 client_channel.cc:1144] chand=000000000221FE98 calld=00000000003734C0: adding pending batch at index 0
I0920 16:58:53.349000000 12304 client_channel.cc:3093] chand=000000000221FE98 calld=00000000003734C0: entering client_channel combiner
I0920 16:58:53.359000000 12304 client_channel.cc:218] chand=000000000221FE98: starting name resolution
D0920 16:58:53.365000000 12304 dns_resolver.cc:289] Start resolving.
I0920 16:58:53.369000000 12304 client_channel.cc:2857] chand=000000000221FE98 calld=00000000003734C0: deferring pick pending resolver result
I0920 16:58:53.379000000 12304 call_combiner.cc:165] call_combiner=0000000000372B10: setting notify_on_cancel=00000000002D4450
I0920 16:58:53.416000000 12304 call.cc:1987] grpc_call_start_batch(call=0000000000372B00, ops=000000000034DDD0, nops=1, tag=0000000002BA6120, reserved=0000000000000000)
I0920 16:58:53.428000000 12304 call.cc:1597] ops[0]: SEND_MESSAGE ptr=00000000021E7F20
I0920 16:58:53.433000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000000373AF0 [executing batch] error="No Error"
I0920 16:58:53.444000000 12304 call_combiner.cc:76] size: 1 -> 2
I0920 16:58:53.447000000 12304 call_combiner.cc:91] QUEUING
I0920 16:58:53.452000000 12304 metadata_array.cc:29] grpc_metadata_array_init(array=0000000002BA6098)
I0920 16:58:53.457000000 12304 metadata_array.cc:29] grpc_metadata_array_init(array=000000000228C1B8)
I0920 16:58:53.462000000 12304 call.cc:1987] grpc_call_start_batch(call=0000000000372B00, ops=0000000002250FB0, nops=4, tag=0000000002BA60F0, reserved=0000000000000000)
I0920 16:58:53.473000000 12304 call.cc:1597] ops[0]: SEND_CLOSE_FROM_CLIENT
I0920 16:58:53.478000000 12304 call.cc:1597] ops[1]: RECV_INITIAL_METADATA ptr=0000000002BA6098
I0920 16:58:53.492000000 12304 call.cc:1597] ops[2]: RECV_MESSAGE ptr=0000000002BEE9D8
I0920 16:58:53.498000000 12304 call.cc:1597] ops[3]: RECV_STATUS_ON_CLIENT metadata=000000000228C1B8 status=000000000228C1D0 details=000000000228C1D8
I0920 16:58:53.508000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000000373BF0 [executing batch] error="No Error"
I0920 16:58:53.517000000 12304 call_combiner.cc:76] size: 2 -> 3
I0920 16:58:53.521000000 12304 call_combiner.cc:91] QUEUING
I0920 16:58:53.524000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:53.537000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:53.543000000 12304 client_channel.cc:485] chand=000000000221FE98: got resolver result: resolver_result=0000000002BEEC70 error="No Error"
I0920 16:58:53.552000000 12304 pick_first.cc:160] Pick First 0000000002BF0820 created.
I0920 16:58:53.559000000 12304 pick_first.cc:371] Pick First 0000000002BF0820 received update with 1 addresses
I0920 16:58:53.570000000 12304 subchannel_list.h:489] [pick_first 0000000002BF0820] Creating subchannel list 0000000002BE5270 for 1 subchannels
I0920 16:58:53.602000000 12304 subchannel_list.h:529] [pick_first 0000000002BF0820] subchannel list 0000000002BE5270 index 0: Created subchannel 0000000002E40690 for address uri ipv4:172.17.131.101:8080
I0920 16:58:53.614000000 12304 client_channel.cc:398] chand=000000000221FE98: created new LB policy "pick_first" (0000000002BF0820)
I0920 16:58:53.626000000 12304 connectivity_state.cc:92] CONWATCH: 0000000002BF0950 pick_first: get IDLE
I0920 16:58:53.642000000 12304 connectivity_state.cc:116] CONWATCH: 0000000002BF0950 pick_first: from IDLE [cur=IDLE] notify=000000000228C3E8
I0920 16:58:53.650000000 12304 client_channel.cc:177] chand=000000000221FE98: setting connectivity state to IDLE
I0920 16:58:53.657000000 12304 connectivity_state.cc:164] SET: 000000000221FF20 client_channel: IDLE --> IDLE [resolver_result] error=0000000000000000 "No Error"
I0920 16:58:53.674000000 12304 client_channel.cc:2946] chand=000000000221FE98 calld=00000000003734C0: resolver returned, doing LB pick
I0920 16:58:53.680000000 12304 client_channel.cc:2785] chand=000000000221FE98 calld=00000000003734C0: applying service config to
call
I0920 16:58:53.689000000 12304 client_channel.cc:2693] chand=000000000221FE98 calld=00000000003734C0: starting pick on lb_policy=0000000002BF0820
I0920 16:58:53.694000000 12304 connectivity_state.cc:92] CONWATCH: 0000000002E40768 subchannel: get IDLE
I0920 16:58:53.698000000 12304 subchannel_list.h:323] [pick_first 0000000002BF0820] subchannel list 0000000002BE5270 index 0 of 1 (subchannel 0000000002E40690): starting watch: requesting connectivity change notification (from IDLE)
I0920 16:58:53.710000000 12304 connectivity_state.cc:116] CONWATCH: 0000000002E40768 subchannel: from IDLE [cur=IDLE] notify=0000000002E3BD08
I0920 16:58:53.715000000 12304 connectivity_state.cc:164] SET: 0000000002E40768 subchannel: IDLE --> CONNECTING [connecting] error=0000000000000000 "No Error"
I0920 16:58:53.722000000 12304 connectivity_state.cc:190] NOTIFY: 0000000002E40768 subchannel: 0000000002E3BD08
I0920 16:58:53.726000000 12304 tcp_client_custom.cc:139] CLIENT_CONNECT: 0000000002BA5E50 ipv4:172.17.131.101:8080: asynchronously connecting
I0920 16:58:53.732000000 12304 call_combiner.cc:165] call_combiner=0000000000372B10: setting notify_on_cancel=0000000000373688
I0920 16:58:53.736000000 12304 call_combiner.cc:174] call_combiner=0000000000372B10: scheduling old cancel callback=00000000002D4450
I0920 16:58:53.746000000 12304 subchannel_list.h:435] [pick_first 0000000002BF0820] subchannel list 0000000002BE5270 index 0 of 1 (subchannel 0000000002E40690): connectivity changed: state=CONNECTING, error="No Error", shutting_down=0
I0920 16:58:53.758000000 12304 connectivity_state.cc:164] SET: 0000000002BF0950 pick_first: IDLE --> CONNECTING [connecting_changed] error=0000000000000000 "No Error"
I0920 16:58:53.763000000 12304 connectivity_state.cc:190] NOTIFY: 0000000002BF0950 pick_first: 000000000228C3E8
I0920 16:58:53.768000000 12304 subchannel_list.h:344] [pick_first 0000000002BF0820] subchannel list 0000000002BE5270 index 0 of 1 (subchannel 0000000002E40690): renewing watch: requesting connectivity change notification (from CONNECTING)
I0920 16:58:53.778000000 12304 connectivity_state.cc:116] CONWATCH: 0000000002E40768 subchannel: from CONNECTING [cur=CONNECTING] notify=0000000002E3BD08
I0920 16:58:53.785000000 12304 client_channel.cc:189] chand=000000000221FE98: lb_policy=0000000002BF0820 state changed to CONNECTING
I0920 16:58:53.793000000 12304 client_channel.cc:177] chand=000000000221FE98: setting connectivity state to CONNECTING
I0920 16:58:53.799000000 12304 connectivity_state.cc:164] SET: 000000000221FF20 client_channel: IDLE --> CONNECTING [lb_changed]
error=0000000000000000 "No Error"
I0920 16:58:53.809000000 12304 connectivity_state.cc:116] CONWATCH: 0000000002BF0950 pick_first: from CONNECTING [cur=CONNECTING] notify=0000000002E4E748
I0920 16:58:53.815000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:53.824000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:53.827000000 12304 tcp_custom.cc:348] Creating TCP endpoint 0000000002BA5E50
I0920 16:58:53.831000000 12304 tcp_client_custom.cc:69] CLIENT_CONNECT: ipv4:172.17.131.101:8080: on_alarm: error="Cancelled"
I0920 16:58:53.841000000 12304 handshaker.cc:141] handshake_manager 0000000002E45490: adding handshaker http_connect [0000000002E53670] at index 0
I0920 16:58:53.849000000 12304 ssl_transport_security.cc:213] HANDSHAKE START - TLS client start_connect - !!!!!!
I0920 16:58:53.855000000 12304 ssl_transport_security.cc:213] LOOP - TLS client enter_early_data - !!!!!!
I0920 16:58:53.861000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_server_hello - !!!!!!
I0920 16:58:53.866000000 12304 handshaker.cc:141] handshake_manager 0000000002E45490: adding handshaker security [0000000002C790E0] at index 1
I0920 16:58:53.875000000 12304 handshaker.cc:212] handshake_manager 0000000002E45490: error="No Error" shutdown=0 index=0, args={endpoint=0000000002DE9900, args=0000000002BEF950 {size=10: grpc.primary_user_agent=grpc-node/1.15.0-pre1, grpc.client_channel_factory=000007FEC6AD2DC0, grpc.channel_credentials=0000000002BA6BA0, grpc.server_uri=dns:///dialogflow.googleapis.com:443, grpc.channelz_channel_node_creation_func=000007FEC6976C50, grpc.http_connect_server=dialogflow.googleapis.com:443, grpc.default_authority=dialogflow.googleapis.com:443, grpc.http2_scheme=https, grpc.security_connector=0000000002DC3190, grpc.subchannel_address=ipv4:172.17.131.101:8080}, read_buffer=00000000003634E0 (length=0), exit_early=0}
I0920 16:58:53.919000000 12304 handshaker.cc:258] handshake_manager 0000000002E45490: calling handshaker http_connect [0000000002E53670] at index 0
I0920 16:58:53.926000000 12304 http_connect_handshaker.cc:300] Connecting to server dialogflow.googleapis.com:443 via HTTP proxy
ipv4:172.17.131.101:8080
I0920 16:58:53.932000000 12304 tcp_custom.cc:234] WRITE 0000000002BA5E50 (peer=ipv4:172.17.131.101:8080): 43 4f 4e 4e 45 43 54 20 64 69 61 6c 6f 67 66 6c 6f 77 2e 67 6f 6f 67 6c 65 61 70 69 73 2e 63 6f 6d 3a 34 34 33 20 48 54 54 50 2f 31 2e 30 0d 0a 48 6f 73 74 3a 20 64 69 61 6c 6f 67 66 6c 6f 77 2e 67 6f 6f 67 6c 65 61 70 69 73 2e 63 6f 6d 3a 34 34 33 0d 0a 55 73 65 72 2d 41 67 65 6e 74 3a 20 67 72 70 63 2d 68 74 74 70 63 6c 69 2f 30 2e 30 0d 0a 0d 0a 'CONNECT dialogflow.googleapis.com:443 HTTP/1.0..Host: dialogflow.googleapis.com:443..User-Agent: grpc-httpcli/0.0....'
I0920 16:58:53.958000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:53.969000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:53.974000000 12304 tcp_custom.cc:217] write complete on 0000000002BA5E50: error="No Error"
I0920 16:58:53.978000000 12304 resource_quota.cc:873] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: alloc 8192; free_pool -> -8192
I0920 16:58:53.982000000 12304 resource_quota.cc:316] RQ: check allocation for user 0000000002D905D0 shutdown=0 free_pool=-8192
I0920 16:58:53.989000000 12304 resource_quota.cc:342] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: grant alloc 8192 bytes; rq_free_pool -> 9223372036854767615
I0920 16:58:53.999000000 12304 tcp_custom.cc:174] TCP:0000000002BA5E50 read_allocation_done: "No Error"
I0920 16:58:54.003000000 12304 tcp_custom.cc:191] Initiating read on 0000000002BA5E50: error="No Error"
I0920 16:58:54.009000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:54.017000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:54.020000000 12304 tcp_custom.cc:128] TCP:0000000002BA5E50 call_cb 0000000002E53828 000007FEC6977750:0000000002E53670
I0920 16:58:54.025000000 12304 tcp_custom.cc:132] read: error="No Error"
I0920 16:58:54.028000000 12304 tcp_custom.cc:137] READ 0000000002DE9900 (peer=ipv4:172.17.131.101:8080): 48 54 54 50 2f 31 2e 30
20 32 30 30 20 4f 4b 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 3a 20 30 0d 0a 0d 0a 'HTTP/1.0 200 OK..Content-Length: 0....'
I0920 16:58:54.040000000 12304 resource_quota.cc:896] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: free 8192; free_pool -> 8192
I0920 16:58:54.046000000 12304 handshaker.cc:212] handshake_manager 0000000002E45490: error="No Error" shutdown=0 index=1, args={endpoint=0000000002DE9900, args=0000000002BEF950 {size=10: grpc.primary_user_agent=grpc-node/1.15.0-pre1, grpc.client_channel_factory=000007FEC6AD2DC0, grpc.channel_credentials=0000000002BA6BA0, grpc.server_uri=dns:///dialogflow.googleapis.com:443, grpc.channelz_channel_node_creation_func=000007FEC6976C50, grpc.http_connect_server=dialogflow.googleapis.com:443, grpc.default_authority=dialogflow.googleapis.com:443, grpc.http2_scheme=https, grpc.security_connector=0000000002DC3190, grpc.subchannel_address=ipv4:172.17.131.101:8080}, read_buffer=00000000003634E0 (length=0), exit_early=0}
I0920 16:58:54.080000000 12304 handshaker.cc:258] handshake_manager 0000000002E45490: calling handshaker security [0000000002C790E0] at index 1
I0920 16:58:54.085000000 12304 tcp_custom.cc:234] WRITE 0000000002BA5E50 (peer=ipv4:172.17.131.101:8080): 16 03 01 00 a0 01 00 00 9c 03 03 03 b0 ed 74 f0 68 96 c3 a2 00 a2 46 67 c0 08 a3 9c 9a 29 2c 86 c9 f7 f7 77 66 19 0a 00 a6 77 ce 00 00 08 c0 2b c0 2c c0 2f c0 30 01 00 00 6b ff 01 00 01 00 00 00 00 1e 00 1c 00 00 19 64 69 61 6c 6f 67 66 6c 6f 77 2e 67 6f 6f 67 6c 65 61 70 69 73 2e 63 6f 6d 00 17 00 00 00 23 00 00 00 0d 00 14 00 12 04 03 08 04 04 01 05 03 08 05 05 01 08 06 06 01 02 01 33 74 00 00 00 10 00 0e 00 0c 08 67 72 70 63 2d 65 78 70 02 68 32 00 0b 00 02 01 00 00 0a 00 04 00 02 00 17 '..............t.h.....Fg.....),....wf....w.....+.,./.0...k..............dialogflow.googleapis.com.....#..........................3t.........grpc-exp.h2..............'
I0920 16:58:54.122000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:54.131000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:54.135000000 12304 tcp_custom.cc:217] write complete on 0000000002BA5E50: error="No Error"
I0920 16:58:54.142000000 12304 resource_quota.cc:873] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: alloc 8192; free_pool -> 0
I0920 16:58:54.149000000 12304 tcp_custom.cc:174] TCP:0000000002BA5E50 read_allocation_done: "No Error"
I0920 16:58:54.154000000 12304 tcp_custom.cc:191] Initiating read on 0000000002BA5E50: error="No Error"
I0920 16:58:54.158000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:54.167000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:54.173000000 12304 tcp_custom.cc:128] TCP:0000000002BA5E50 call_cb 0000000002C792B8 000007FEC693B6F0:0000000002C790E0
I0920 16:58:54.179000000 12304 tcp_custom.cc:132] read: error="No Error"
I0920 16:58:54.182000000 12304 tcp_custom.cc:137] READ 0000000002DE9900 (peer=ipv4:172.17.131.101:8080): 16 03 03 00 4e 02 00 00
4a 03 03 5b a3 84 76 c6 de 9b b1 d2 a9 f0 37 e6 57 ef 53 8a 9e d8 33 b2 63 46 b1 22 b5 59 40 85 36 66 90 00 c0 2b 00 00 22 ff 01
00 01 00 00 17 00 00 00 23 00 00 00 10 00 0b 00 09 08 67 72 70 63 2d 65 78 70 00 0b 00 02 01 00 16 03 03 08 95 0b 00 08 91 00 08
8e 00 04 28 30 82 04 24 30 82 03 0c a0 03 02 01 02 02 08 72 d2 eb 27 36 62 df 9e 30 0d 06 09 2a 86 48 86 f7 0d 01 01 0b 05 00 30
54 31 0b 30 09 06 03 55 04 06 13 02 55 53 31 1e 30 1c 06 03 55 04 0a 13 15 47 6f 6f 67 6c 65 20 54 72 75 73 74 20 53 65 72 76 69
63 65 73 31 25 30 23 06 03 55 04 03 13 1c 47 6f 6f 67 6c 65 20 49 6e 74 65 72 6e 65 74 20 41 75 74 68 6f 72 69 74 79 20 47 33 30
1e 17 0d 31 38 30 38 32 38 31 38 32 33 30 30 5a 17 0d 31 38 31 31 32 30 31 38 32 33 30 30 5a 30 6a 31 0b 30 09 06 03 55 04 06 13
02 55 53 31 13 30 11 06 03 55 04 08 0c 0a 43 61 6c 69 66 6f 72 6e 69 61 31 16 30 14 06 03 55 04 07 0c 0d 4d 6f 75 6e 74 61 69 6e
20 56 69 65 77 31 13 30 11 06 03 55 04 0a 0c 0a 47 6f 6f 67 6c 65 20 4c 4c 43 31 19 30 17 06 03 55 04 03 0c 10 2a 2e 67 6f 6f 67
6c 65 61 70 69 73 2e 63 6f 6d 30 59 30 13 06 07 2a 86 48 ce 3d 02 01 06 08 2a 86 48 ce 3d 03 01 07 03 42 00 04 1b 8f 76 c2 7d 6c
42 f3 5a 93 34 32 3e 3d ea fd cd d2 e4 36 fc 15 3a f8 cb 58 34 13 af 9c e4 dd 28 4c 42 78 ad 1f d4 0e 78 f7 14 7b fe bd bb 12 fe
47 f8 4f 99 fa 7b 82 ad fc 08 4a 2b 15 37 84 a3 82 01 ad 30 82 01 a9 30 13 06 03 55 1d 25 04 0c 30 0a 06 08 2b 06 01 05 05 07 03
01 30 0e 06 03 55 1d 0f 01 01 ff 04 04 03 02 07 80 30 74 06 03 55 1d 11 04 6d 30 6b 82 10 2a 2e 67 6f 6f 67 6c 65 61 70 69 73 2e
63 6f 6d 82 15 2a 2e 63 6c 69 65 6e 74 73 36 2e 67 6f 6f 67 6c 65 2e 63 6f 6d 82 18 2a 2e 63 6c 6f 75 64 65 6e 64 70 6f 69 6e 74
73 61 70 69 73 2e 63 6f 6d 82 16 63 6c 6f 75 64 65 6e 64 70 6f 69 6e 74 73 61 70 69 73 2e 63 6f 6d 82 0e 67 6f 6f 67 6c 65 61 70
69 73 2e 63 6f 6d 30 68 06 08 2b 06 01 05 05 07 01 01 04 5c 30 5a 30 2d 06 08 2b 06 01 05 05 07 30 02 86 21 68 74 74 70 3a 2f 2f
70 6b 69 2e 67 6f 6f 67 2f 67 73 72 32 2f 47 54 53 47 49 41 47 33 2e 63 72 74 30 29 06 08 2b 06 01 05 05 07 30 01 86 1d 68 74 74
70 3a 2f 2f 6f 63 73 70 2e 70 6b 69 2e 67 6f 6f 67 2f 47 54 53 47 49 41 47 33 30 1d 06 03 55 1d 0e 04 16 04 14 fe bf 86 f1 2d 6c
98 e9 1a 77 20 f7 7f dc db d2 33 af 25 e0 30 0c 06 03 55 1d 13 01 01 ff 04 02 30 00 30 1f 06 03 55 1d 23 04 18 30 16 80 14 77 c2
b8 50 9a 67 76 76 b1 2d c2 86 d0 83 a0 7e a6 7e ba 4b 30 21 06 03 55 1d 20 04 1a 30 18 30 0c 06 0a 2b 06 01 04 01 d6 79 02 05 03
30 08 06 06 67 81 0c 01 02 02 30 31 06 03 55 1d 1f 04 2a 30 28 30 26 a0 24 a0 22 86 20 68 74 74 70 3a 2f 2f 63 72 6c 2e 70 6b 69
2e 67 6f 6f 67 2f 47 54 53 47 49 41 47 33 2e 63 72 6c 30 0d 06 09 2a 86 48 86 f7 0d 01 01 0b 05 00 03 82 01 01 00 79 e5 38 5a f2
83 72 3a 06 6f 9e 12 df c8 5b 33 ad 00 0f 54 36 f4 ce e0 94 cd cb 2f 5d 76 4a 01 fc 61 f0 b6 58 58 d7 e5 0e 92 2e d8 c2 33 57 be
d8 5c d2 bc 27 48 c9 62 a2 12 79 3f 10 dd 21 d7 4d c6 f1 d1 84 47 3b 3e 3e eb ad 47 a3 ff 1a 86 45 88 58 ee 52 5a 1c 72 a5 36 c6
17 74 90 1b 73 28 9c dc 98 10 6e 02 ab 68 4a 29 d1 10 7d 63 12 42 12 ac 7e 8e 3f 10 8c 2d ea 09 2d dd 3c 9a ce 8f 26 74 9c 5f 56
b7 51 d1 05 a9 0b b1 be 11 ff 37 d1 8e 10 87 12 96 1f a7 90 57 cf 70 72 dd 67 f2 19 50 7b 78 c9 2e 0e 4e 92 ea 15 3e 6a 30 f1 12
34 7e 41 b1 91 fb ae 38 84 eb 3e f6 c4 50 17 e6 80 dc ad e0 30 7e 6f 41 00 41 2b a6 5a 8f 3e d0 f3 74 67 2f 98 ae 94 06 d4 50 ec
19 8e fe 70 3d dc 3e 5e c7 be 37 51 06 7a da 9f c3 67 21 37 66 20 c7 f6 02 64 4e 96 21 9b 15 d0 b5 47 c7 9d 00 04 60 30 82 04 5c
30 82 03 44 a0 03 02 01 02 02 0d 01 e3 a9 30 1c fc 72 06 38 3f 9a 53 1d 30 0d 06 09 2a 86 48 86 f7 0d 01 01 0b 05 00 30 4c 31 20
30 1e 06 03 55 04 0b 13 17 47 6c 6f 62 61 6c 53 69 67 6e 20 52 6f 6f 74 20 43 41 20 2d 20 52 32 31 13 30 11 06 03 55 04 0a 13 0a
47 6c 6f 62 61 6c 53 69 67 6e 31 13 30 11 06 03 55 04 03 13 0a 47 6c 6f 62 61 6c 53 69 67 6e 30 1e 17 0d 31 37 30 36 31 35 30 30
30 30 34 32 5a 17 0d 32 31 31 32 31 35 30 30 30 30 34 32 5a 30 54 31 0b 30 09 06 03 55 04 06 13 02 55 53 31 1e 30 1c 06 03 55 04
0a 13 15 47 6f 6f 67 6c 65 20 54 72 75 73 74 20 53 65 72 76 69 63 65 73 31 25 30 23 06 03 55 04 03 13 1c 47 6f 6f 67 6c 65 20 49
6e 74 65 72 6e 65 74 20 41 75 74 68 6f 72 69 74 79 20 47 33 30 82 01 22 30 0d 06 09 2a 86 48 86 f7 0d '....N...J..[..v.......7.W.S...3.cF."[email protected]...+.."..........#.........grpc-exp....................(0..$0..........r..'6b..0...*.H........0T1.0...U....US1.0...U....Google Trust Services1%0#..U....Google Internet Authority G30...180828182300Z..181120182300Z0j1.0...U....US1.0...U....California1.0...U....Mountain View1.0...U....Google LLC1.0...U....*.googleapis.com0Y0...*.H.=....*.H.=....B....v.}lB.Z.42>=.....6..:..X4.....(LBx....x..{.....G.O..{....J+.7.....0...0...U.%..0...+.......0...U...........0t..U...m0k..*.googleapis.com..*.clients6.google.com..*.cloudendpointsapis.com..cloudendpointsapis.com..googleapis.com0h..+........\0Z0-..+.....0..!http://pki.goog/gsr2/GTSGIAG3.crt0)..+.....0...http://ocsp.pki.goog/GTSGIAG30...U..........-l...w .....3.%.0...U.......0.0...U.#..0...w..P.gvv.-.....~.~.K0!..U. ..0.0...+.....y...0...g.....01..U...*0(0&.$.". http://crl.pki.goog/GTSGIAG3.crl0...*.H.............y.8Z..r:.o....[3...T6....../]vJ..a..XX.......3W..\..'H.b..y?..!.M....G;>>..G....E.X.RZ.r.6..t..s(....n..hJ)..}c.B..~.?..-..-.<...&t._V.Q........7.........W.pr.g..P{x...N...>j0..4~A....8..>..P......0~oA.A+.Z.>..tg/.....P....p=.>^..7Q.z...g!7f ...dN.!....G....`0..\0..D..........0..r.8?.S.0...*.H........0L1 0...U....GlobalSign Root CA - R21.0...U....GlobalSign1.0...U....GlobalSign0...170615000042Z..211215000042Z0T1.0...U....US1.0...U....Google Trust Services1%0#..U....Google Internet Authority G30.."0...*.H...'
I0920 16:58:54.441000000 12304 resource_quota.cc:896] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: free 8192; free_pool -> 8192
I0920 16:58:54.447000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_server_certifi - !!!!!!
I0920 16:58:54.452000000 12304 resource_quota.cc:873] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: alloc 8192; free_pool -> 0
I0920 16:58:54.458000000 12304 tcp_custom.cc:174] TCP:0000000002BA5E50 read_allocation_done: "No Error"
I0920 16:58:54.462000000 12304 tcp_custom.cc:191] Initiating read on 0000000002BA5E50: error="No Error"
I0920 16:58:54.467000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:54.480000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:54.486000000 12304 tcp_custom.cc:128] TCP:0000000002BA5E50 call_cb 0000000002C792B8 000007FEC693B6F0:0000000002C790E0
I0920 16:58:54.493000000 12304 tcp_custom.cc:132] read: error="No Error"
I0920 16:58:54.496000000 12304 tcp_custom.cc:137] READ 0000000002DE9900 (peer=ipv4:172.17.131.101:8080): 01 01 01 05 00 03 82 01
0f 00 30 82 01 0a 02 82 01 01 00 ca 52 4b ea 1e ff ce 24 6b a8 da 72 18 68 d5 56 5d 0e 48 5a 2d 35 09 76 5a cf a4 c8 1c b1 a9 fe
53 89 fb ad 34 ff 88 5b 9f bb e7 e8 00 01 dc 35 73 75 03 ad b3 b1 b9 a4 7d 2b 26 79 ce 15 40 0a ef 51 b8 9f 32 8c 7c 70 86 52 4b
16 fe 6a 27 6b e6 36 7a 62 50 d8 df 9a 89 cc 09 29 eb 4f 29 14 88 80 0b 8f 38 1e 80 6a 18 7c 1d bd 97 3b 78 7d 45 49 36 4f 41 cd
a2 e0 76 57 3c 68 31 79 64 c9 6e d7 51 1e 66 c3 a2 64 2c 79 c0 e7 65 c3 56 84 53 5a 43 6d cb 9a 02 20 d2 ef 1a 69 d1 b0 9d 73 a2
e0 2a 60 65 50 31 cf fb b3 2f bf 11 88 40 2e b5 49 10 0f 0a 6e dc 97 fa bf 2c 9f 05 39 0b 58 54 af 06 96 e8 c5 8e 01 16 bc a8 1a
4d 41 c5 93 91 a2 1e a1 8b f2 fe c1 88 24 49 a3 47 4b c5 13 01 dd a7 57 12 69 62 2b eb fe 20 ef 69 fb 3a a5 f0 7e 29 ee ed 96 16
f7 b1 1f a0 e4 90 25 e0 33 02 03 01 00 01 a3 82 01 33 30 82 01 2f 30 0e 06 03 55 1d 0f 01 01 ff 04 04 03 02 01 86 30 1d 06 03 55
1d 25 04 16 30 14 06 08 2b 06 01 05 05 07 03 01 06 08 2b 06 01 05 05 07 03 02 30 12 06 03 55 1d 13 01 01 ff 04 08 30 06 01 01 ff
02 01 00 30 1d 06 03 55 1d 0e 04 16 04 14 77 c2 b8 50 9a 67 76 76 b1 2d c2 86 d0 83 a0 7e a6 7e ba 4b 30 1f 06 03 55 1d 23 04 18
30 16 80 14 9b e2 07 57 67 1c 1e c0 6a 06 de 59 b4 9a 2d df dc 19 86 2e 30 35 06 08 2b 06 01 05 05 07 01 01 04 29 30 27 30 25 06
08 2b 06 01 05 05 07 30 01 86 19 68 74 74 70 3a 2f 2f 6f 63 73 70 2e 70 6b 69 2e 67 6f 6f 67 2f 67 73 72 32 30 32 06 03 55 1d 1f
04 2b 30 29 30 27 a0 25 a0 23 86 21 68 74 74 70 3a 2f 2f 63 72 6c 2e 70 6b 69 2e 67 6f 6f 67 2f 67 73 72 32 2f 67 73 72 32 2e 63
72 6c 30 3f 06 03 55 1d 20 04 38 30 36 30 34 06 06 67 81 0c 01 02 02 30 2a 30 28 06 08 2b 06 01 05 05 07 02 01 16 1c 68 74 74 70
73 3a 2f 2f 70 6b 69 2e 67 6f 6f 67 2f 72 65 70 6f 73 69 74 6f 72 79 2f 30 0d 06 09 2a 86 48 86 f7 0d 01 01 0b 05 00 03 82 01 01
00 1c b7 89 96 e4 53 ed bb ec db a8 32 01 9f 2c a3 cd 6d ad 42 12 77 b3 b8 e6 c9 03 52 60 20 7b 57 27 c6 11 b5 3f 67 0d 99 2c 5b
5a ca 22 0a dd 9e bb 1f 4b 48 3f 8f 02 3d 8b 21 84 45 1d 6d f5 ff ac 68 89 cd 64 e2 d6 d6 5e 40 c2 8e 2a f7 ef 14 d3 36 a4 40 30
f5 32 15 15 92 76 fb 7e 9e 53 ea c2 76 fc 39 ad 88 fe 66 92 26 e9 1c c4 38 cd 49 fa 43 87 f0 5d d6 56 4d 81 d7 7f f1 c2 dd b0 4d
fe c3 2a 6e 7c 9f 6e 5c ed 62 42 99 e1 f7 36 ee 14 8c 2c 20 e3 46 97 5a 77 03 c0 a0 c6 4a 88 fd 40 22 87 72 5a 18 ea 9c a5 c7 5a
08 8c e4 05 a4 7d b9 84 35 5f 89 36 56 0e 40 3d 12 e8 bb 35 72 ed af 08 56 4e b0 bb 2e a9 9b e4 fb 1d 3e 0b 63 c8 9b 4b 91 44 66
57 c0 14 b4 96 f0 dc 2c 57 3f 52 04 ad 95 aa 7d 4d d0 f2 0c 9f 9c 40 e8 d6 55 73 ba 3c df 90 cb 00 5b 21 11 67 c2 ed 32 1e de 16
03 03 00 95 0c 00 00 91 03 00 17 41 04 b1 68 ed f6 92 31 64 87 18 4e 1f c7 8c c6 6f 4a 36 b1 c5 cb 32 f3 d9 ee 1d c6 f1 a8 05 30
97 57 48 88 b9 a7 f8 d2 35 f8 c1 d7 af 85 a7 18 a2 36 3c 7a d4 1f 81 70 92 b6 1d ae fe 22 4f 1d b9 9b 04 03 00 48 30 46 02 21 00
c2 b9 4c c7 79 9e 92 86 0a a6 9f e4 2a 03 ad 14 fb 0b ff f4 59 1b 88 6b ed c3 d8 39 6a 07 a9 f1 02 21 00 e4 b6 3b db 31 4c 87 05
f7 21 42 76 6f 9b ec a4 46 fc 40 26 60 2d e0 f7 a7 5c 82 a5 47 1a 34 c2 16 03 03 00 04 0e 00 00 00 '..........0.........RK....$k..r.h.V].HZ-5.vZ.......S...4..[.......5su......}+&[email protected].|p.RK..j'k.6zbP......).O).....8..j.|...;x}EI6OA...vW<h1yd.n.Q.f..d,y..e.V.SZCm... ...i...s..*`eP1.../[email protected]....,..9.XT...........MA...........$I.GK.....W.ib+.. .i.:..~)..........%.3........30../0...U...........0...U.%..0...+.........+.......0...U.......0.......0...U......w..P.gvv.-.....~.~.K0...U.#..0......Wg...j..Y..-.....05..+........)0'0%..+.....0...http://ocsp.pki.goog/gsr202..U...+0)0'.%.#.!http://crl.pki.goog/gsr2/gsr2.crl0?..U. .80604..g.....0*0(..+.........https://pki.goog/repository/0...*.H..................S.....2..,..m.B.w.....R` {W'...?g..,[Z.".....KH?..=.!.E.m...h..d...^@..*[email protected].~.S..v.9...f.&...8.I.C..].VM.......M..*n|.n\.bB...6..., .F.Zw....J..@".rZ.....Z.....}..5_.6V.@=...5r...VN........>.c..K.DfW......,W?R....}[email protected].<....[!.g..2..............A..h...1d..N....oJ6...2........0.WH.....5........6<z...p....."O......H0F.!...L.y.......*.......Y..k...9j....!...;.1L...!Bvo...F.@&`-...\..G.4..........'
I0920 16:58:54.689000000 12304 resource_quota.cc:896] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: free 8192; free_pool -> 8192
I0920 16:58:54.695000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_certificate_st - !!!!!!
I0920 16:58:54.699000000 12304 ssl_transport_security.cc:213] LOOP - TLS client verify_server_certi - !!!!!!
I0920 16:58:54.706000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_server_key_exc - !!!!!!
I0920 16:58:54.711000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_certificate_re - !!!!!!
I0920 16:58:54.714000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_server_hello_d - !!!!!!
I0920 16:58:54.719000000 12304 ssl_transport_security.cc:213] LOOP - TLS client send_client_certifi - !!!!!!
I0920 16:58:54.727000000 12304 ssl_transport_security.cc:213] LOOP - TLS client send_client_key_exc - !!!!!!
I0920 16:58:54.734000000 12304 ssl_transport_security.cc:213] LOOP - TLS client send_client_certifi - !!!!!!
I0920 16:58:54.740000000 12304 ssl_transport_security.cc:213] LOOP - TLS client send_client_finishe - !!!!!!
I0920 16:58:54.745000000 12304 ssl_transport_security.cc:213] LOOP - TLS client finish_flight - !!!!!!
I0920 16:58:54.750000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_session_ticket - !!!!!!
I0920 16:58:54.754000000 12304 tcp_custom.cc:234] WRITE 0000000002BA5E50 (peer=ipv4:172.17.131.101:8080): 16 03 03 00 46 10 00 00 42 41 04 da 8c 92 2d 06 24 04 65 ec 56 aa ea 2b f6 af 90 a1 e7 16 c7 a8 21 f0 78 f4 7b 0f c2 89 04 fe 53 b1 19 d1 26 ff ef 1e 6b 9a 7b 64 d3 d4 65 3c 94 a0 8a c2 06 6f 6a 83 47 3d 99 28 dd 64 89 c7 07 14 03 03 00 01 01 16 03 03 00 28 00 00 00 00 00 00 00 00 5b da a1 05 fd 5d 14 77 04 6f 30 4f a8 a9 ed e9 8a ac 91 f3 aa 3d 83 95 16 17 f5 73 bf 27 28 0d '....F...BA....-.$.e.V..+........!.x.{.....S...&...k.{d..e<.....oj.G=.(.d.............(........[....].w.o0O.........=.....s.'(.'
I0920 16:58:54.781000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:54.789000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:54.794000000 12304 tcp_custom.cc:217] write complete on 0000000002BA5E50: error="No Error"
I0920 16:58:54.799000000 12304 resource_quota.cc:873] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: alloc 8192; free_pool -> 0
I0920 16:58:54.803000000 12304 tcp_custom.cc:174] TCP:0000000002BA5E50 read_allocation_done: "No Error"
I0920 16:58:54.806000000 12304 tcp_custom.cc:191] Initiating read on 0000000002BA5E50: error="No Error"
I0920 16:58:54.812000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:54.822000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:54.828000000 12304 tcp_custom.cc:128] TCP:0000000002BA5E50 call_cb 0000000002C792B8 000007FEC693B6F0:0000000002C790E0
I0920 16:58:54.835000000 12304 tcp_custom.cc:132] read: error="No Error"
I0920 16:58:54.838000000 12304 tcp_custom.cc:137] READ 0000000002DE9900 (peer=ipv4:172.17.131.101:8080): 16 03 03 00 e4 04 00 00
e0 00 01 89 c0 00 da 00 f0 ee 14 52 64 db 9f d1 2e f0 02 d8 41 b1 1d d9 06 c3 85 d5 33 45 9b 81 a2 93 16 41 50 fe e0 33 2c 47 ce
2f 53 8b d6 45 ea b6 42 e2 49 33 71 82 ea 30 c9 39 d1 cc 1b 11 14 f4 19 cc a2 5d fa 60 97 a6 4b 0a 46 3d bd ae 12 8b 19 83 cd f8
d1 4b 23 c1 6e 29 23 1d e8 0c 7a 1d bc 45 02 2b 76 9b b5 9b 6a c7 07 85 c3 7f 69 0f a0 2c 79 ae 6b 9d b0 a6 78 93 3b 01 a8 91 c0
3b 97 bf 76 1d 94 05 f0 b6 ad 84 6e e2 b5 d5 b2 66 ea dd 88 e4 42 22 56 42 41 cf a9 3b df ac a8 c2 f1 27 9e 81 d1 ba 44 66 c2 a1
b5 08 f1 01 7b bf 5b 59 9f 26 01 b5 77 d3 63 47 00 0e 03 92 ec 63 fb ce 18 15 56 81 fc de 6d dd 88 3e 95 df 42 08 27 21 3a f9 ab
2c c6 02 fe 3c 44 42 11 85 09 14 03 03 00 01 01 16 03 03 00 28 00 00 00 00 00 00 00 00 c0 63 ed 27 5c dd 4c fb a2 af f6 62 e9 72
a1 56 dc 34 ff 2d 50 73 42 ff 7d 55 b0 8a d5 ec 86 33 17 03 03 00 40 00 00 00 00 00 00 00 01 fd 2c 39 8a 72 97 41 69 0a 8a 03 fc
7b 4d 2c 50 a8 d2 96 2c 17 d7 93 78 78 51 ec bb 19 38 2e 47 f1 8e a4 48 ff b2 94 96 c5 73 73 94 03 17 40 23 e4 18 97 d8 5e 93 5d
58 '...................Rd.......A.......3E.....AP..3,G./S..E..B.I3q..0.9.........].`..K.F=.........K#.n)#...z..E.+v...j.....i..,y.k...x.;....;..v.......n....f....B"VBA..;.....'....Df......{.[Y.&..w.cG.....c....V...m..>..B.'!:..,...<DB.............(.........c.'\.L....b.r.V.4.-PsB.}U.....3....@.........,9.r.Ai....{M,P...,...xxQ...8.G...H.....ss...@#....^.]X'
I0920 16:58:54.934000000 12304 resource_quota.cc:896] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: free 8192; free_pool -> 8192
I0920 16:58:54.939000000 12304 ssl_transport_security.cc:213] LOOP - TLS client process_change_ciph - !!!!!!
I0920 16:58:54.944000000 12304 ssl_transport_security.cc:213] LOOP - TLS client read_server_finishe - !!!!!!
I0920 16:58:54.948000000 12304 ssl_transport_security.cc:213] LOOP - TLS client finish_client_hands - !!!!!!
I0920 16:58:54.959000000 12304 ssl_transport_security.cc:213] LOOP - TLS client done - !!!!!!
I0920 16:58:54.966000000 12304 ssl_transport_security.cc:213] HANDSHAKE DONE - TLS client done - !!!!!!
I0920 16:58:54.973000000 12304 security_context.cc:295] grpc_auth_context_add_cstring_property(ctx=0000000002E62ED0, name=transport_security_type, value=ssl)
I0920 16:58:54.980000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=x509_common_name, value=*.googleapis.com, value_length=16)
I0920 16:58:54.988000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=x509_pem_cert,
value=-----BEGIN CERTIFICATE-----
MIIEJDCCAwygAwIBAgIIctLrJzZi354wDQYJKoZIhvcNAQELBQAwVDELMAkGA1UE
BhMCVVMxHjAcBgNVBAoTFUdvb2dsZSBUcnVzdCBTZXJ2aWNlczElMCMGA1UEAxMc
R29vZ2xlIEludGVybmV0IEF1dGhvcml0eSBHMzAeFw0xODA4MjgxODIzMDBaFw0x
ODExMjAxODIzMDBaMGoxCzAJBgNVBAYTAlVTMRMwEQYDVQQIDApDYWxpZm9ybmlh
MRYwFAYDVQQHDA1Nb3VudGFpbiBWaWV3MRMwEQYDVQQKDApHb29nbGUgTExDMRkw
FwYDVQQDDBAqLmdvb2dsZWFwaXMuY29tMFkwEwYHKoZIzj0CAQYIKoZIzj0DAQcD
QgAEG492wn1sQvNakzQyPj3q/c3S5Db8FTr4y1g0E6+c5N0oTEJ4rR/UDnj3FHv+
vbsS/kf4T5n6e4Kt/AhKKxU3hKOCAa0wggGpMBMGA1UdJQQMMAoGCCsGAQUFBwMB
MA4GA1UdDwEB/wQEAwIHgDB0BgNVHREEbTBrghAqLmdvb2dsZWFwaXMuY29tghUq
LmNsaWVudHM2Lmdvb2dsZS5jb22CGCouY2xvdWRlbmRwb2ludHNhcGlzLmNvbYIW
Y2xvdWRlbmRwb2ludHNhcGlzLmNvbYIOZ29vZ2xlYXBpcy5jb20waAYIKwYBBQUH
AQEEXDBaMC0GCCsGAQUFBzAChiFodHRwOi8vcGtpLmdvb2cvZ3NyMi9HVFNHSUFH
My5jcnQwKQYIKwYBBQUHMAGGHWh0dHA6Ly9vY3NwLnBraS5nb29nL0dUU0dJQUcz
MB0GA1UdDgQWBBT+v4bxLWyY6Rp3IPd/3NvSM68l4DAMBgNVHRMBAf8EAjAAMB8G
A1UdIwQYMBaAFHfCuFCaZ3Z2sS3ChtCDoH6mfrpLMCEGA1UdIAQaMBgwDAYKKwYB
BAHWeQIFAzAIBgZngQwBAgIwMQYDVR0fBCowKDAmoCSgIoYgaHR0cDovL2NybC5w
a2kuZ29vZy9HVFNHSUFHMy5jcmwwDQYJKoZIhvcNAQELBQADggEBAHnlOFryg3I6
Bm+eEt/IWzOtAA9UNvTO4JTNyy9ddkoB/GHwtlhY1+UOki7YwjNXvthc0rwnSMli
ohJ5PxDdIddNxvHRhEc7Pj7rrUej/xqGRYhY7lJaHHKlNsYXdJAbcyic3JgQbgKr
aEop0RB9YxJCEqx+jj8QjC3qCS3dPJrOjyZ0nF9Wt1HRBakLsb4R/zfRjhCHEpYf
p5BXz3By3WfyGVB7eMkuDk6S6hU+ajDxEjR+QbGR+644hOs+9sRQF+aA3K3gMH5v
QQBBK6Zajz7Q83RnL5iulAbUUOwZjv5wPdw+Xse+N1EGetqfw2chN2Ygx/YCZE6W
IZsV0LVHx50=
-----END CERTIFICATE-----
, value_length=1497)
I0920 16:58:55.069000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=x509_subject_alternative_name, value=*.googleapis.com, value_length=16)
I0920 16:58:55.078000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=x509_subject_alternative_name, value=*.clients6.google.com, value_length=21)
I0920 16:58:55.086000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=x509_subject_alternative_name, value=*.cloudendpointsapis.com, value_length=24)
I0920 16:58:55.093000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=x509_subject_alternative_name, value=cloudendpointsapis.com, value_length=22)
I0920 16:58:55.109000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=x509_subject_alternative_name, value=googleapis.com, value_length=14)
I0920 16:58:55.116000000 12304 security_context.cc:279] grpc_auth_context_add_property(ctx=0000000002E62ED0, name=ssl_session_reused, value=false, value_length=5)
I0920 16:58:55.125000000 12304 security_context.cc:246] grpc_auth_context_find_properties_by_name(ctx=0000000002E62ED0, name=x509_subject_alternative_name)
I0920 16:58:55.130000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D1E8)
I0920 16:58:55.134000000 12304 security_context.cc:194] grpc_auth_context_set_peer_identity_property_name(ctx=0000000002E62ED0, name=x509_subject_alternative_name)
I0920 16:58:55.141000000 12304 handshaker.cc:212] handshake_manager 0000000002E45490: error="No Error" shutdown=0 index=2, args={endpoint=0000000002E60C60, args=0000000002E50500 {size=11: grpc.primary_user_agent=grpc-node/1.15.0-pre1, grpc.client_channel_factory=000007FEC6AD2DC0, grpc.channel_credentials=0000000002BA6BA0, grpc.server_uri=dns:///dialogflow.googleapis.com:443, grpc.channelz_channel_node_creation_func=000007FEC6976C50, grpc.http_connect_server=dialogflow.googleapis.com:443, grpc.default_authority=dialogflow.googleapis.com:443, grpc.http2_scheme=https, grpc.security_connector=0000000002DC3190, grpc.subchannel_address=ipv4:172.17.131.101:8080, grpc.auth_context=0000000002E62ED0}, read_buffer=00000000003634E0 (length=0), exit_early=0}
I0920 16:58:55.178000000 12304 handshaker.cc:245] handshake_manager 0000000002E45490: handshaking complete -- scheduling on_handshake_done with error="No Error"
I0920 16:58:55.187000000 12304 bdp_estimator.h:53] bdp[ipv4:172.17.131.101:8080]:sched acc=0 est=65536
I0920 16:58:55.191000000 12304 chttp2_transport.cc:813] W:0000000002E71350 CLIENT state IDLE -> WRITING [TRANSPORT_FLOW_CONTROL]
I0920 16:58:55.199000000 12304 chttp2_transport.cc:813] W:0000000002E71350 CLIENT state WRITING -> WRITING+MORE [INITIAL_WRITE]
I0920 16:58:55.205000000 12304 subchannel.cc:630] New connected subchannel at 0000000002BDECF0 for subchannel 0000000002E40690
I0920 16:58:55.210000000 12304 chttp2_transport.cc:1822] perform_transport_op[t=0000000002E71350]: ON_CONNECTIVITY_STATE_CHANGE:p=0000000002E63390:from=READY BIND_POLLSET_SET
I0920 16:58:55.217000000 12304 connectivity_state.cc:164] SET: 0000000002E40768 subchannel: CONNECTING --> READY [connected] error=0000000000000000 "No Error"
I0920 16:58:55.223000000 12304 connectivity_state.cc:190] NOTIFY: 0000000002E40768 subchannel: 0000000002E3BD08
I0920 16:58:55.227000000 12304 resource_quota.cc:873] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: alloc 8192; free_pool -> 0
I0920 16:58:55.232000000 12304 tcp_custom.cc:174] TCP:0000000002BA5E50 read_allocation_done: "No Error"
I0920 16:58:55.236000000 12304 tcp_custom.cc:191] Initiating read on 0000000002BA5E50: error="No Error"
I0920 16:58:55.240000000 12304 connectivity_state.cc:116] CONWATCH: 0000000002E715F0 client_transport: from READY [cur=READY] notify=0000000002E63390
D0920 16:58:55.246000000 12304 flow_control.cc:113] 0000000002E72990[0][cli] | t updt sent | trw: 65535,
ttw: 4194304, taw: 65535 -> 4194304, srw: , slw:
, saw:
I0920 16:58:55.262000000 12304 writing.cc:110] CLIENT: Ping sent [0000000002BDCEC0]: 2/2
I0920 16:58:55.266000000 12304 chttp2_transport.cc:813] W:0000000002E71350 CLIENT state WRITING+MORE -> WRITING [begin write in current thread]
I0920 16:58:55.271000000 12304 secure_endpoint.cc:272] WRITE 0000000002E60C60: 50 52 49 20 2a 20 48 54 54 50 2f 32 2e 30 0d 0a 0d 0a 53 4d 0d 0a 0d 0a 'PRI * HTTP/2.0....SM....'
I0920 16:58:55.280000000 12304 secure_endpoint.cc:272] WRITE 0000000002E60C60: 00 00 24 04 00 00 00 00 00 00 02 00 00 00 00 00 03 00 00 00 00 00 04 00 40 00 00 00 05 00 40 00 00 00 06 00 00 20 00 fe 03 00 00 00 01 '..$.....................@.....@...... .......'
I0920 16:58:55.289000000 12304 secure_endpoint.cc:272] WRITE 0000000002E60C60: 00 00 04 08 00 00 00 00 00 00 3f 00 01 00 00 08 06 00 00 00 00 00 00 '..........?............'
I0920 16:58:55.295000000 12304 secure_endpoint.cc:272] WRITE 0000000002E60C60: 00 00 00 00 00 00 00 '.......'
I0920 16:58:55.299000000 12304 tcp_custom.cc:234] WRITE 0000000002BA5E50 (peer=ipv4:172.17.131.101:8080): 17 03 03 00 7b 00 00 00 00 00 00 00 01 8b 13 8f 3a c5 f8 ef b8 e0 1f 2b a4 59 da d8 ba 7c 5b 2b 44 5f c1 ea 30 90 2b a0 9b 9e 52 1a e2 3c 6d a9 9e d6 62 00 d4 5a b9 00 31 b3 3f bb 90 db 3b b4 5f c3 d6 13 67 79 b3 4e b8 d8 46 f1 a8 a8 60 4f 96 05 25 a3 c4 36 02 69 b8 b8 73 f7 dd 3c 7f 87 b5 5c 94 9f 2d c1 0e 40 53 58 7b b2 5a c0 6a 90 e3 f6 f6 2c b1 8b 19 0f 77 76 44 74 16 88 06 7b '....{...........:......+.Y...|[+D_..0.+...R..<m...b..Z..1.?...;._...gy.N..F...`O..%..6.i..s..<...\..-..@SX{.Z.j....,....wvDt...{'
I0920 16:58:55.328000000 12304 chttp2_transport.cc:2553] ipv4:172.17.131.101:8080: Start BDP ping err="No Error"
I0920 16:58:55.332000000 12304 bdp_estimator.h:66] bdp[ipv4:172.17.131.101:8080]:start acc=0 est=65536
I0920 16:58:55.337000000 12304 subchannel_list.h:435] [pick_first 0000000002BF0820] subchannel list 0000000002BE5270 index 0 of 1 (subchannel 0000000002E40690): connectivity changed: state=READY, error="No Error", shutting_down=0
I0920 16:58:55.346000000 12304 connectivity_state.cc:164] SET: 0000000002BF0950 pick_first: CONNECTING --> READY [subchannel_ready] error=0000000000000000 "No Error"
I0920 16:58:55.352000000 12304 connectivity_state.cc:190] NOTIFY: 0000000002BF0950 pick_first: 0000000002E4E748
I0920 16:58:55.356000000 12304 pick_first.cc:601] Pick First 0000000002BF0820 selected subchannel 0000000002E40690
I0920 16:58:55.365000000 12304 pick_first.cc:611] Servicing pending pick with selected subchannel 0000000002E40690
I0920 16:58:55.370000000 12304 subchannel_list.h:344] [pick_first 0000000002BF0820] subchannel list 0000000002BE5270 index 0 of 1 (subchannel 0000000002E40690): renewing watch: requesting connectivity change notification (from READY)
I0920 16:58:55.380000000 12304 connectivity_state.cc:116] CONWATCH: 0000000002E40768 subchannel: from READY [cur=READY] notify=0000000002E3BD08
I0920 16:58:55.386000000 12304 client_channel.cc:189] chand=000000000221FE98: lb_policy=0000000002BF0820 state changed to READY
I0920 16:58:55.391000000 12304 client_channel.cc:177] chand=000000000221FE98: setting connectivity state to READY
I0920 16:58:55.394000000 12304 connectivity_state.cc:164] SET: 000000000221FF20 client_channel: CONNECTING --> READY [lb_changed] error=0000000000000000 "No Error"
I0920 16:58:55.399000000 12304 connectivity_state.cc:116] CONWATCH: 0000000002BF0950 pick_first: from READY [cur=READY] notify=0000000002E4EBA8
I0920 16:58:55.411000000 12304 client_channel.cc:2749] chand=000000000221FE98 calld=00000000003734C0: pick completed asynchronously
I0920 16:58:55.416000000 12304 client_channel.cc:2597] chand=000000000221FE98 calld=00000000003734C0: create subchannel_call=0000000002E74D40: error="No Error"
I0920 16:58:55.422000000 12304 client_channel.cc:1286] chand=000000000221FE98 calld=00000000003734C0: starting 1 pending batches
on subchannel_call=0000000002E74D40
I0920 16:58:55.429000000 12304 call_combiner.h:153] CallCombinerClosureList executing closure while already holding call_combiner 0000000000372B10: closure=0000000000373A90 error="No Error" reason=pending_batches_resume
I0920 16:58:55.438000000 12304 subchannel.cc:727] OP[authority:0000000002E74DA0]: SEND_INITIAL_METADATA{key=3a 70 61 74 68 ':path' value=2f 67 6f 6f 67 6c 65 2e 63 6c 6f 75 64 2e 64 69 61 6c 6f 67 66 6c 6f 77 2e 76 32 2e 53 65 73 73 69 6f 6e 73 2f 44 65 74
65 63 74 49 6e 74 65 6e 74 '/google.cloud.dialogflow.v2.Sessions/DetectIntent', key=78 2d 67 6f 6f 67 2d 61 70 69 2d 63 6c 69 65
6e 74 'x-goog-api-client' value=67 6c 2d 6e 6f 64 65 2f 76 31 30 2e 31 30 2e 30 20 67 72 70 63 2f 31 2e 31 35 2e 30 20 67 61 78 2f 30 2e 31 37 2e 31 20 67 61 70 69 63 2f 30 2e 36 2e 30 'gl-node/v10.10.0 grpc/1.15.0 gax/0.17.1 gapic/0.6.0' deadline=220316}
I0920 16:58:55.464000000 12304 channel_stack.cc:225] OP[client-auth:0000000002E74DB8]: SEND_INITIAL_METADATA{key=3a 61 75 74 68
6f 72 69 74 79 ':authority' value=64 69 61 6c 6f 67 66 6c 6f 77 2e 67 6f 6f 67 6c 65 61 70 69 73 2e 63 6f 6d 3a 34 34 33 'dialogflow.googleapis.com:443', key=3a 70 61 74 68 ':path' value=2f 67 6f 6f 67 6c 65 2e 63 6c 6f 75 64 2e 64 69 61 6c 6f 67 66 6c 6f 77 2e 76 32 2e 53 65 73 73 69 6f 6e 73 2f 44 65 74 65 63 74 49 6e 74 65 6e 74 '/google.cloud.dialogflow.v2.Sessions/DetectIntent',
key=78 2d 67 6f 6f 67 2d 61 70 69 2d 63 6c 69 65 6e 74 'x-goog-api-client' value=67 6c 2d 6e 6f 64 65 2f 76 31 30 2e 31 30 2e 30
20 67 72 70 63 2f 31 2e 31 35 2e 30 20 67 61 78 2f 30 2e 31 37 2e 31 20 67 61 70 69 63 2f 30 2e 36 2e 30 'gl-node/v10.10.0 grpc/1.15.0 gax/0.17.1 gapic/0.6.0' deadline=220316}
I0920 16:58:55.493000000 12304 security_context.cc:212] grpc_auth_context_property_iterator(ctx=0000000002E62ED0)
I0920 16:58:55.497000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.501000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.505000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.509000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.516000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.522000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.528000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.532000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.536000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.540000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.544000000 12304 security_context.cc:212] grpc_auth_context_property_iterator(ctx=0000000002E62ED0)
I0920 16:58:55.549000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.552000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.557000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.566000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.571000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.576000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.581000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.584000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.589000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.594000000 12304 security_context.cc:220] grpc_auth_property_iterator_next(it=000000000019D2E0)
I0920 16:58:55.597000000 12304 plugin_credentials.cc:174] plugin_credentials[00000000002ED2C0]: request 0000000002E63410: invoking plugin
I0920 16:58:55.603000000 12304 plugin_credentials.cc:187] plugin_credentials[00000000002ED2C0]: request 0000000002E63410: plugin
will return asynchronously
I0920 16:58:55.609000000 12304 call_combiner.cc:165] call_combiner=0000000000372B10: setting notify_on_cancel=0000000002E74FC8
I0920 16:58:55.613000000 12304 call_combiner.cc:174] call_combiner=0000000000372B10: scheduling old cancel callback=0000000000373688
I0920 16:58:55.624000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:55.632000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:55.635000000 12304 tcp_custom.cc:217] write complete on 0000000002BA5E50: error="No Error"
I0920 16:58:55.638000000 12304 chttp2_transport.cc:813] W:0000000002E71350 CLIENT state WRITING -> IDLE [finish writing]
I0920 16:58:55.642000000 12304 tcp_custom.cc:128] TCP:0000000002BA5E50 call_cb 0000000002E60CC0 000007FEC6961680:0000000002E60C60
I0920 16:58:55.645000000 12304 tcp_custom.cc:132] read: error="No Error"
I0920 16:58:55.647000000 12304 tcp_custom.cc:137] READ 0000000002DE9900 (peer=ipv4:172.17.131.101:8080): 17 03 03 00 32 00 00 00
00 00 00 00 02 e7 27 b9 9d d5 9b 35 4f 15 3a 72 da d7 35 7c e6 bf e0 0d 66 3d 28 86 bb 8b e6 e7 00 07 b3 b7 7d 3d fc a3 45 fd 7f
93 d9 91 75 '....2.........'....5O.:r..5|....f=(.........}=..E.....u'
I0920 16:58:55.658000000 12304 resource_quota.cc:896] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: free 8192; free_pool -> 8192
I0920 16:58:55.668000000 12304 secure_endpoint.cc:136] READ 0000000002E60C60: 00 00 12 04 00 00 00 00 00 00 03 00 00 00 64 00 04
00 10 00 00 00 06 00 00 40 00 00 00 04 08 00 00 00 00 00 00 0f 00 01 00 00 00 04 01 00 00 00 00 00 00 08 06 01 00 00 00 00 00 00
00 00 00 00 00 00 '..............d..........@........................................'
I0920 16:58:55.679000000 12304 frame_settings.cc:227] CHTTP2:CLI:ipv4:172.17.131.101:8080: got setting MAX_CONCURRENT_STREAMS = 100
I0920 16:58:55.685000000 12304 frame_settings.cc:220] 0000000002E71350[cli] adding 983041 for initial_window change
I0920 16:58:55.689000000 12304 frame_settings.cc:227] CHTTP2:CLI:ipv4:172.17.131.101:8080: got setting INITIAL_WINDOW_SIZE = 1048576
I0920 16:58:55.694000000 12304 frame_settings.cc:227] CHTTP2:CLI:ipv4:172.17.131.101:8080: got setting MAX_HEADER_LIST_SIZE = 16384
D0920 16:58:55.699000000 12304 flow_control.cc:113] 0000000002E72990[0][cli] | t updt recv | trw: 65535 -> 1048576,
ttw: 4194304, taw: 4194304, srw: , slw:
, saw:
I0920 16:58:55.709000000 12304 resource_quota.cc:873] RQ anonymous_pool_225e170 ipv4:172.17.131.101:8080: alloc 8192; free_pool -> 0
I0920 16:58:55.716000000 12304 tcp_custom.cc:174] TCP:0000000002BA5E50 read_allocation_done: "No Error"
I0920 16:58:55.723000000 12304 tcp_custom.cc:191] Initiating read on 0000000002BA5E50: error="No Error"
I0920 16:58:55.727000000 12304 chttp2_transport.cc:2566] ipv4:172.17.131.101:8080: Complete BDP ping err="No Error"
I0920 16:58:55.731000000 12304 bdp_estimator.cc:50] bdp[ipv4:172.17.131.101:8080]:complete acc=66 est=65536 dt=0.393651 bw=0.001341Mbs bw_est=0.000000Mbs
I0920 16:58:55.794000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:55.802000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:55.808000000 12304 bdp_estimator.h:53] bdp[ipv4:172.17.131.101:8080]:sched acc=0 est=65536
I0920 16:58:55.813000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:55.820000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:55.826000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:55.833000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:55.837000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:55.849000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:58.161000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:58.180000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:58:58.192000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:58:58.213000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:01.175000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:01.232000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:01.246000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:01.270000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:03.196000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:03.208000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:03.213000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:03.227000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:08.217000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:08.237000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:08.250000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:08.277000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.305000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.323000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.331000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.350000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.359000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.376000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.384000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.407000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.423000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.439000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.446000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.466000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.476000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.508000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.519000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.534000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.546000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.561000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.574000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.601000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.610000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.627000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.637000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.652000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.661000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.678000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.694000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.710000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.718000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.734000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.753000000 12304 credentials.cc:76] grpc_channel_credentials_release(creds=0000000002BA6BA0)
I0920 16:59:09.761000000 12304 credentials.cc:98] grpc_call_credentials_release(creds=00000000002ED2C0)
I0920 16:59:09.768000000 12304 credentials.cc:76] grpc_channel_credentials_release(creds=000000000228C110)
I0920 16:59:09.777000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.806000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.813000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.827000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.836000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.851000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:09.859000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:09.881000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:10.842000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:10.864000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:10.913000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:10.958000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:10.968000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:10.999000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.010000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.033000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.044000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.164000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.178000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.204000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.217000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.245000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.265000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.291000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.302000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.329000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.358000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.379000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.392000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.418000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.434000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.457000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.471000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.503000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.516000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.537000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.549000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.570000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.581000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.611000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.622000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.643000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.653000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.679000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.689000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.709000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.742000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.763000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:11.774000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:11.794000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:13.248000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:13.262000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:13.274000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:13.354000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:18.335000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:18.356000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:18.363000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:18.378000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:23.359000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:23.376000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:23.389000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:23.413000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:28.399000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:28.410000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:28.415000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:28.426000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:33.415000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:33.420000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:33.423000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:33.429000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:38.423000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:38.429000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:38.432000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:38.437000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:43.431000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:43.452000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:43.462000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:43.513000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:48.493000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:48.507000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:48.546000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:48.555000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:53.508000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:53.552000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:53.572000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:53.592000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:58.542000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:58.568000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 16:59:58.577000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 16:59:58.596000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 17:00:03.577000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:03.662000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 17:00:03.694000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:03.736000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 17:00:08.657000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:08.663000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
I0920 17:00:08.671000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:08.685000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
Auth error:Error: Client network socket disconnected before secure TLS connection was established
I0920 17:00:10.878000000 12304 metadata_array.cc:29] grpc_metadata_array_init(array=000000000019BFA8)
I0920 17:00:10.888000000 12304 plugin_credentials.cc:126] plugin_credentials[00000000002ED2C0]: request 0000000002E63410: plugin
returned asynchronously
I0920 17:00:10.907000000 12304 call_combiner.h:153] CallCombinerClosureList executing closure while already holding call_combiner 0000000000372B10: closure=0000000000373A18 error={"created":"@1537443010.907000000","description":"Getting metadata from plugin
failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14} reason=failing on_complete
I0920 17:00:10.974000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [on_complete]
I0920 17:00:10.987000000 12304 call_combiner.cc:111] size: 3 -> 2
I0920 17:00:10.995000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:11.053000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=0000000000373AF0 error="No Error"
I0920 17:00:11.068000000 12304 call_combiner.cc:202] call_combiner=0000000000372B10: scheduling notify_on_cancel callback=0000000002E74FC8
I0920 17:00:11.089000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=000000000034E078 [executing batch] error="No Error"
I0920 17:00:11.110000000 12304 call_combiner.cc:76] size: 2 -> 3
I0920 17:00:11.119000000 12304 call_combiner.cc:91] QUEUING
I0920 17:00:11.128000000 12304 completion_queue.cc:691] cq_end_op_for_next(cq=0000000002C7BC20, tag=0000000002BA6AE0, error={"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}, done=000007FEC69068B0, done_arg=00000000003739C0, storage=00000000003739C8)
E0920 17:00:11.257000000 12304 completion_queue.cc:693] Operation failed: tag=0000000002BA6AE0, error={"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.297000000 12304 call.cc:642] OP[client-channel:00000000003734A0]: SEND_MESSAGE:flags=0x00000000:len=80
I0920 17:00:11.306000000 12304 client_channel.cc:1144] chand=000000000221FE98 calld=00000000003734C0: adding pending batch at index 1
I0920 17:00:11.321000000 12304 client_channel.cc:3081] chand=000000000221FE98 calld=00000000003734C0: starting batch on subchannel_call=0000000002E74D40
I0920 17:00:11.331000000 12304 client_channel.cc:1286] chand=000000000221FE98 calld=00000000003734C0: starting 1 pending batches
on subchannel_call=0000000002E74D40
I0920 17:00:11.343000000 12304 call_combiner.h:153] CallCombinerClosureList executing closure while already holding call_combiner 0000000000372B10: closure=0000000000373B90 error="No Error" reason=pending_batches_resume
I0920 17:00:11.384000000 12304 subchannel.cc:727] OP[authority:0000000002E74DA0]: SEND_MESSAGE:flags=0x00000000:len=80
I0920 17:00:11.393000000 12304 channel_stack.cc:225] OP[client-auth:0000000002E74DB8]: SEND_MESSAGE:flags=0x00000000:len=80
I0920 17:00:11.400000000 12304 channel_stack.cc:225] OP[message_size:0000000002E74DD0]: SEND_MESSAGE:flags=0x00000000:len=80
I0920 17:00:11.409000000 12304 channel_stack.cc:225] OP[http-client:0000000002E74DE8]: SEND_MESSAGE:flags=0x00000000:len=80
I0920 17:00:11.420000000 12304 channel_stack.cc:225] OP[message_compress:0000000002E74E00]: SEND_MESSAGE:flags=0x00000000:len=80
I0920 17:00:11.430000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [send_message batch pending send_initial_metadata]
I0920 17:00:11.446000000 12304 call_combiner.cc:111] size: 3 -> 2
I0920 17:00:11.456000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:11.461000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=0000000000373BF0 error="No Error"
I0920 17:00:11.470000000 12304 call.cc:642] OP[client-channel:00000000003734A0]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA
RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.482000000 12304 client_channel.cc:1144] chand=000000000221FE98 calld=00000000003734C0: adding pending batch at index 2
I0920 17:00:11.492000000 12304 client_channel.cc:3081] chand=000000000221FE98 calld=00000000003734C0: starting batch on subchannel_call=0000000002E74D40
I0920 17:00:11.505000000 12304 client_channel.cc:1286] chand=000000000221FE98 calld=00000000003734C0: starting 1 pending batches
on subchannel_call=0000000002E74D40
I0920 17:00:11.517000000 12304 call_combiner.h:153] CallCombinerClosureList executing closure while already holding call_combiner 0000000000372B10: closure=0000000000373C90 error="No Error" reason=pending_batches_resume
I0920 17:00:11.540000000 12304 subchannel.cc:727] OP[authority:0000000002E74DA0]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.554000000 12304 channel_stack.cc:225] OP[client-auth:0000000002E74DB8]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.567000000 12304 channel_stack.cc:225] OP[message_size:0000000002E74DD0]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.579000000 12304 channel_stack.cc:225] OP[http-client:0000000002E74DE8]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.592000000 12304 channel_stack.cc:225] OP[message_compress:0000000002E74E00]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.606000000 12304 channel_stack.cc:225] OP[connected:0000000002E74E18]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.622000000 12304 chttp2_transport.cc:1658] perform_stream_op[s=0000000002E75928]: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA
I0920 17:00:11.643000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [passed batch to transport]
I0920 17:00:11.653000000 12304 call_combiner.cc:111] size: 2 -> 1
I0920 17:00:11.659000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:11.664000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=000000000034E078 error="No Error"
I0920 17:00:11.673000000 12304 call.cc:642] OP[client-channel:00000000003734A0]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.706000000 12304 client_channel.cc:3055] chand=000000000221FE98 calld=00000000003734C0: recording cancel_error={"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected
before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.751000000 12304 subchannel.cc:727] OP[authority:0000000002E74DA0]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.781000000 12304 channel_stack.cc:225] OP[client-auth:0000000002E74DB8]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.822000000 12304 channel_stack.cc:225] OP[message_size:0000000002E74DD0]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection
was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.854000000 12304 channel_stack.cc:225] OP[http-client:0000000002E74DE8]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.892000000 12304 channel_stack.cc:225] OP[message_compress:0000000002E74E00]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.920000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000002D6FC90 [failing send_message op] error={"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.951000000 12304 call_combiner.cc:76] size: 1 -> 2
I0920 17:00:11.963000000 12304 call_combiner.cc:91] QUEUING
I0920 17:00:11.968000000 12304 channel_stack.cc:225] OP[connected:0000000002E74E18]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:11.995000000 12304 chttp2_transport.cc:1658] perform_stream_op[s=0000000002E75928]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:12.023000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [passed batch to transport]
I0920 17:00:12.040000000 12304 call_combiner.cc:111] size: 2 -> 1
I0920 17:00:12.043000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:12.048000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=0000000002D6FC90 error={"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:12.078000000 12304 call_combiner.h:153] CallCombinerClosureList executing closure while already holding call_combiner 0000000000372B10: closure=0000000000373B18 error={"created":"@1537443010.907000000","description":"Getting metadata from plugin
failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14} reason=failing on_complete
I0920 17:00:12.123000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [on_complete]
I0920 17:00:12.131000000 12304 call_combiner.cc:111] size: 1 -> 0
I0920 17:00:12.135000000 12304 call_combiner.cc:139] queue empty
I0920 17:00:12.140000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=000000000034E018 [executing batch] error="No Error"
I0920 17:00:12.149000000 12304 call_combiner.cc:76] size: 0 -> 1
I0920 17:00:12.154000000 12304 call_combiner.cc:85] EXECUTING IMMEDIATELY
I0920 17:00:12.160000000 12304 completion_queue.cc:691] cq_end_op_for_next(cq=0000000002C7BC20, tag=0000000002BA6120, error={"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}, done=000007FEC69068B0, done_arg=0000000000373AC0, storage=0000000000373AC8)
E0920 17:00:12.213000000 12304 completion_queue.cc:693] Operation failed: tag=0000000002BA6120, error={"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:12.253000000 12304 call.cc:642] OP[client-channel:00000000003734A0]: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:12.290000000 12304 client_channel.cc:3036] chand=000000000221FE98 calld=00000000003734C0: failing batch with error: {"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:12.318000000 12304 call_combiner.h:153] CallCombinerClosureList executing closure while already holding call_combiner 0000000000372B10: closure=0000000002CEE020 error={"created":"@1537443010.907000000","description":"Getting metadata from plugin
failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14} reason=failing on_complete
I0920 17:00:12.359000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [on_complete for cancel_stream op]
I0920 17:00:12.368000000 12304 call_combiner.cc:111] size: 1 -> 0
I0920 17:00:12.374000000 12304 call_combiner.cc:139] queue empty
I0920 17:00:12.379000000 12304 chttp2_transport.cc:1358] perform_stream_op_locked: SEND_TRAILING_METADATA{} RECV_INITIAL_METADATA RECV_MESSAGE RECV_TRAILING_METADATA; on_complete = 0000000002E75768
I0920 17:00:12.390000000 12304 chttp2_transport.cc:1209] complete_closure_step: t=0000000002E71350 0000000002E75768 refs=1 flags=0x0001 desc=op->on_complete err="No Error" write_state=IDLE
I0920 17:00:12.401000000 12304 chttp2_transport.cc:1358] perform_stream_op_locked: CANCEL:{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}; on_complete = 0000000002222BC0
I0920 17:00:12.441000000 12304 chttp2_transport.cc:1209] complete_closure_step: t=0000000002E71350 0000000002E75768 refs=0 flags=0x0001 desc=send_trailing_metadata_finished err={"created":"@1537443012.441000000","description":"Pending writes failed due to stream closure","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":2120,"referenced_errors":[{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}]} write_state=IDLE
I0920 17:00:12.486000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000000373C18 [on_complete] error={"created":"@1537443012.486000000","description":"Error in HTTP transport completing operation","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":1222,"referenced_errors":[{"created":"@1537443012.441000000","description":"Pending writes failed due to stream closure","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":2120,"referenced_errors":[{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}]}],"target_address":"ipv4:172.17.131.101:8080"}
I0920 17:00:12.560000000 12304 call_combiner.cc:76] size: 0 -> 1
I0920 17:00:12.564000000 12304 call_combiner.cc:85] EXECUTING IMMEDIATELY
I0920 17:00:12.569000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000002E75000 [recv_message_ready] error="No Error"
I0920 17:00:12.579000000 12304 call_combiner.cc:76] size: 1 -> 2
I0920 17:00:12.584000000 12304 call_combiner.cc:91] QUEUING
I0920 17:00:12.587000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000002E75150 [recv_trailing_metadata_ready] error="No Error"
I0920 17:00:12.604000000 12304 call_combiner.cc:76] size: 2 -> 3
I0920 17:00:12.609000000 12304 call_combiner.cc:91] QUEUING
I0920 17:00:12.613000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000002E75118 [recv_initial_metadata_ready] error="No Error"
I0920 17:00:12.628000000 12304 call_combiner.cc:76] size: 3 -> 4
I0920 17:00:12.631000000 12304 call_combiner.cc:91] QUEUING
I0920 17:00:12.635000000 12304 chttp2_transport.cc:1209] complete_closure_step: t=0000000002E71350 0000000002222BC0 refs=0 flags=0x0000 desc=op->on_complete err="No Error" write_state=IDLE
I0920 17:00:12.646000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=0000000002CEDCF0 [on_complete (cancel_stream)] error="No Error"
I0920 17:00:12.657000000 12304 call_combiner.cc:76] size: 4 -> 5
I0920 17:00:12.662000000 12304 call_combiner.cc:91] QUEUING
I0920 17:00:12.680000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [on_complete]
I0920 17:00:12.692000000 12304 call_combiner.cc:111] size: 5 -> 4
I0920 17:00:12.697000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:12.702000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=0000000002E75000 error="No Error"
I0920 17:00:12.710000000 12304 call_combiner.cc:67] ==> grpc_call_combiner_start() [0000000000372B10] closure=000000000034E018 [executing batch] error="No Error"
I0920 17:00:12.719000000 12304 call_combiner.cc:76] size: 4 -> 5
I0920 17:00:12.724000000 12304 call_combiner.cc:91] QUEUING
I0920 17:00:12.728000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [recv_message_ready]
I0920 17:00:12.735000000 12304 call_combiner.cc:111] size: 5 -> 4
I0920 17:00:12.739000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:12.743000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=0000000002E75150 error="No Error"
I0920 17:00:12.751000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [recv_trailing_metadata_ready]
I0920 17:00:12.767000000 12304 call_combiner.cc:111] size: 4 -> 3
I0920 17:00:12.770000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:12.775000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=0000000002E75118 error="No Error"
I0920 17:00:12.782000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [recv_initial_metadata_ready]
I0920 17:00:12.794000000 12304 call_combiner.cc:111] size: 3 -> 2
I0920 17:00:12.798000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:12.802000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=0000000002CEDCF0 error="No Error"
I0920 17:00:12.809000000 12304 call.cc:774] get_final_status CLI
I0920 17:00:12.815000000 12304 call.cc:777] 1: {"created":"@1537443012.782000000","description":"Error received from peer","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\surface\call.cc","file_line":1099,"grpc_message":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","grpc_status":14}
I0920 17:00:12.840000000 12304 call.cc:777] 2: {"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:12.874000000 12304 completion_queue.cc:691] cq_end_op_for_next(cq=0000000002C7BC20, tag=0000000002BA60F0, error="No Error", done=000007FEC69068B0, done_arg=0000000000373BC0, storage=0000000000373BC8)
I0920 17:00:12.885000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [on_complete for cancel_stream op]
I0920 17:00:12.892000000 12304 call_combiner.cc:111] size: 2 -> 1
I0920 17:00:12.895000000 12304 call_combiner.cc:118] checking queue
I0920 17:00:12.898000000 12304 call_combiner.cc:132] EXECUTING FROM QUEUE: closure=000000000034E018 error="No Error"
I0920 17:00:12.904000000 12304 call.cc:642] OP[client-channel:00000000003734A0]: CANCEL:{"created":"@1537443012.486000000","description":"Error in HTTP transport completing operation","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":1222,"referenced_errors":[{"created":"@1537443012.441000000","description":"Pending writes failed due to stream closure","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\ext\transport\chttp2\transport\chttp2_transport.cc","file_line":2120,"referenced_errors":[{"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}]}],"target_address":"ipv4:172.17.131.101:8080"}
I0920 17:00:12.977000000 12304 client_channel.cc:3036] chand=000000000221FE98 calld=00000000003734C0: failing batch with error: {"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:13.011000000 12304 call_combiner.h:153] CallCombinerClosureList executing closure while already holding call_combiner 0000000000372B10: closure=0000000002CEE020 error={"created":"@1537443010.907000000","description":"Getting metadata from plugin
failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14} reason=failing on_complete
I0920 17:00:13.055000000 12304 call_combiner.cc:104] ==> grpc_call_combiner_stop() [0000000000372B10] [on_complete for cancel_stream op]
I0920 17:00:13.068000000 12304 call_combiner.cc:111] size: 1 -> 0
I0920 17:00:13.072000000 12304 call_combiner.cc:139] queue empty
I0920 17:00:13.078000000 12304 metadata_array.cc:34] grpc_metadata_array_destroy(array=000000000019BFA8)
I0920 17:00:13.086000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:13.100000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: OP_COMPLETE: tag:0000000002BA6AE0 ERROR
I0920 17:00:13.109000000 12304 metadata_array.cc:34] grpc_metadata_array_destroy(array=0000000002BA6A88)
I0920 17:00:13.132000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:13.148000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: OP_COMPLETE: tag:0000000002BA6120 ERROR
I0920 17:00:13.157000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:13.169000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: OP_COMPLETE: tag:0000000002BA60F0 OK
I0920 17:00:13.183000000 12304 call.cc:589] grpc_call_unref(c=0000000000372B00)
I0920 17:00:13.189000000 12304 call_combiner.cc:154] call_combiner=0000000000372B10: scheduling notify_on_cancel callback=0000000000000000 for pre-existing cancellation
I0920 17:00:13.201000000 12304 call.cc:774] get_final_status CLI
I0920 17:00:13.205000000 12304 call.cc:777] 1: {"created":"@1537443012.782000000","description":"Error received from peer","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\surface\call.cc","file_line":1099,"grpc_message":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","grpc_status":14}
I0920 17:00:13.279000000 12304 call.cc:777] 2: {"created":"@1537443010.907000000","description":"Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established","file":"t:\src\github\grpc-node\packages\grpc-native-core\deps\grpc\src\core\lib\security\credentials\plugin\plugin_credentials.cc","file_line":82,"grpc_status":14}
I0920 17:00:13.362000000 12304 metadata_array.cc:34] grpc_metadata_array_destroy(array=0000000002BA6098)
I0920 17:00:13.367000000 12304 metadata_array.cc:34] grpc_metadata_array_destroy(array=000000000228C1B8)
I0920 17:00:13.377000000 12304 completion_queue.cc:954] grpc_completion_queue_next(cq=0000000002C7BC20, deadline=gpr_timespec { tv_sec: -9223372036854775808, tv_nsec: 0, clock_type: 0 }, reserved=0000000000000000)
I0920 17:00:13.390000000 12304 completion_queue.cc:1054] RETURN_EVENT[0000000002C7BC20]: QUEUE_TIMEOUT
ERROR: { Error: 14 UNAVAILABLE: Getting metadata from plugin failed with error: Client network socket disconnected before secure
TLS connection was established
at Object.exports.createStatusError (C:\Users\prateek.g\Source\Repos\dialogflow-importer\node_modules\grpc\src\common.js:87:15)
at Object.onReceiveStatus (C:\Users\prateek.g\Source\Repos\dialogflow-importer\node_modules\grpc\src\client_interceptors.js:1188:28)
at InterceptingListener._callNext (C:\Users\prateek.g\Source\Repos\dialogflow-importer\node_modules\grpc\src\client_interceptors.js:564:42)
at InterceptingListener.onReceiveStatus (C:\Users\prateek.g\Source\Repos\dialogflow-importer\node_modules\grpc\src\client_interceptors.js:614:8)
at callback (C:\Users\prateek.g\Source\Repos\dialogflow-importer\node_modules\grpc\src\client_interceptors.js:841:24)
code: 14,
metadata: Metadata { _internal_repr: {} },
details:
'Getting metadata from plugin failed with error: Client network socket disconnected before secure TLS connection was established' }
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment