Created
June 14, 2019 00:57
-
-
Save afirth/ca016f72fc98a05e3d8145911d70f3a8 to your computer and use it in GitHub Desktop.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
time="2019-06-14T00:20:28Z" level=info msg="running version stable-2.3.2" | |
INFO [ 0.001275s] linkerd2_proxy::app::main using destination service at Some(ControlAddr { addr: Name(NameAddr { name: "linkerd-destination.linkerd.svc.cluster.local", port: 8086 }), identity: Some("linkerd-controller.linkerd.serviceaccount.identity.linkerd.cluster.local") }) | |
INFO [ 0.001575s] linkerd2_proxy::app::main using identity service at Name(NameAddr { name: "linkerd-identity.linkerd.svc.cluster.local", port: 8080 }) | |
INFO [ 0.001750s] linkerd2_proxy::app::main routing on V4(127.0.0.1:4140) | |
INFO [ 0.001961s] linkerd2_proxy::app::main proxying on V4(0.0.0.0:4143) to None | |
INFO [ 0.002152s] linkerd2_proxy::app::main serving admin endpoint metrics on V4(0.0.0.0:4191) | |
INFO [ 0.002277s] linkerd2_proxy::app::main protocol detection disabled for inbound ports {25, 3306} | |
INFO [ 0.002407s] linkerd2_proxy::app::main protocol detection disabled for outbound ports {25, 3306} | |
INFO [ 0.004537s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.007093s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.008887s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.009846s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.010666s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.011524s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.012361s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.016025s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.019684s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.022317s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.025046s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.027728s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
INFO [ 0.030501s] trust_dns_proto::xfer::dns_exchange sending message via: UDP(10.11.240.10:53) | |
DBUG [ 0.035287s] linkerd-identity.linkerd.svc.cluster.local:8080 h2::client binding client connection | |
DBUG [ 0.035504s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::client client connection bound | |
DBUG [ 0.035654s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write send; frame=Settings { flags: (0x0), enable_push: 0 } | |
TRCE [ 0.035780s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::frame::settings encoding SETTINGS; len=6 | |
TRCE [ 0.035982s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::frame::settings encoding setting; val=EnablePush(0) | |
TRCE [ 0.036102s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write encoded settings; rem=15 | |
TRCE [ 0.036226s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 0.036341s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 0.036453s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize Prioritize::new; flow=FlowControl { window_size: Window(65535), available: Window(65535) } | |
TRCE [ 0.036647s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.036759s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.036970s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll; bytes=9B | |
TRCE [ 0.037120s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read decoding frame from 9B | |
TRCE [ 0.037242s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read -> kind=Settings | |
DBUG [ 0.037354s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read received; frame=Settings { flags: (0x0) } | |
TRCE [ 0.037466s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x0) } | |
TRCE [ 0.037581s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=Some(Settings { flags: (0x0) }) | |
DBUG [ 0.037695s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write send; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 0.037817s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 0.037948s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write encoded settings; rem=24 | |
TRCE [ 0.038081s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings ACK sent; applying settings | |
TRCE [ 0.038223s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.038360s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.038472s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize poll_complete | |
TRCE [ 0.038588s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 0.038697s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame | |
TRCE [ 0.038803s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flush | |
TRCE [ 0.038814s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 0.038876s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flushing buffer | |
TRCE [ 0.038885s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.039122s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 0.039135s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 0.039147s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::send send_headers; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) }; init_window=65535 | |
TRCE [ 0.039162s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_send; StreamId(1) | |
TRCE [ 0.039167s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store Queue::push | |
TRCE [ 0.039170s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store -> first entry | |
TRCE [ 0.039178s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize reserve_capacity; stream=StreamId(1); requested=1; effective=1; curr=0 | |
TRCE [ 0.039183s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try_assign_capacity; stream=StreamId(1), requested=1; additional=1; buffered=0; window=65535; conn=65535 | |
TRCE [ 0.039188s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize assigning; stream=StreamId(1), capacity=1 | |
TRCE [ 0.039192s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::stream assigned capacity to stream; available=1; buffered=0; id=StreamId(1) | |
TRCE [ 0.039196s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::stream notifying task | |
TRCE [ 0.039200s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try_assign_capacity(2); available=1; requested=1; buffered=0; has_unavailable=true | |
TRCE [ 0.039230s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize send_data; sz=1432; buffered=1432; requested=1 | |
TRCE [ 0.039234s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try_assign_capacity; stream=StreamId(1), requested=1432; additional=1431; buffered=1432; window=65535; conn=65534 | |
TRCE [ 0.039239s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize assigning; stream=StreamId(1), capacity=1431 | |
TRCE [ 0.039242s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::stream assigned capacity to stream; available=1432; buffered=1432; id=StreamId(1) | |
TRCE [ 0.039246s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try_assign_capacity(2); available=1432; requested=1432; buffered=1432; has_unavailable=true | |
TRCE [ 0.039251s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store Queue::push | |
TRCE [ 0.039275s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store -> already queued | |
TRCE [ 0.039279s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize send_data (2); available=1432; buffered=1432 | |
TRCE [ 0.039286s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_send; StreamId(1) | |
TRCE [ 0.039291s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store Queue::push | |
TRCE [ 0.039294s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store -> already queued | |
TRCE [ 0.039298s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Open { local: Streaming, remote: AwaitingHeaders } }; is_closed=false; pending_send_empty=false; buffered_send_data=1432; num_recv=0; num_send=1 | |
TRCE [ 0.039306s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize reserve_capacity; stream=StreamId(1); requested=1; effective=1433; curr=1432 | |
TRCE [ 0.039311s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try_assign_capacity; stream=StreamId(1), requested=1433; additional=1; buffered=1432; window=65535; conn=64103 | |
TRCE [ 0.039315s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize assigning; stream=StreamId(1), capacity=1 | |
TRCE [ 0.039319s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::stream assigned capacity to stream; available=1433; buffered=1432; id=StreamId(1) | |
TRCE [ 0.039323s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::stream notifying task | |
TRCE [ 0.039327s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try_assign_capacity(2); available=1433; requested=1433; buffered=1432; has_unavailable=true | |
TRCE [ 0.039331s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store Queue::push | |
TRCE [ 0.039335s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store -> already queued | |
TRCE [ 0.039344s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize reserve_capacity; stream=StreamId(1); requested=0; effective=1432; curr=1433 | |
TRCE [ 0.039348s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize assign_connection_capacity; inc=1 | |
TRCE [ 0.039354s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize send_data; sz=0; buffered=1432; requested=1432 | |
TRCE [ 0.039358s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::state send_close: Open => HalfClosedLocal(AwaitingHeaders) | |
TRCE [ 0.039362s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize reserve_capacity; stream=StreamId(1); requested=0; effective=1432; curr=1432 | |
TRCE [ 0.039366s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize send_data (2); available=1432; buffered=1432 | |
TRCE [ 0.039370s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_send; StreamId(1) | |
TRCE [ 0.039375s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store Queue::push | |
TRCE [ 0.039379s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store -> already queued | |
TRCE [ 0.039382s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: HalfClosedLocal(AwaitingHeaders) }; is_closed=false; pending_send_empty=false; buffered_send_data=1432; num_recv=0; num_send=1 | |
TRCE [ 0.039389s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::streams drop_stream_ref; stream=Stream { id: StreamId(1), state: State { inner: HalfClosedLocal(AwaitingHeaders) }, is_counted: true, ref_count: 2, next_pending_send: None, is_pending_send: true, send_flow: FlowControl { window_size: Window(65535), available: Window(1432) }, requested_send_capacity: 1432, buffered_send_data: 1432, send_task: Some(Task), pending_send: Deque { indices: Some(Indices { head: 0, tail: 2 }) }, next_pending_send_capacity: None, is_pending_send_capacity: false, send_capacity_inc: true, next_open: None, is_pending_open: false, next_pending_accept: None, is_pending_accept: false, recv_flow: FlowControl { window_size: Window(65535), available: Window(65535) }, in_flight_recv_data: 0, next_window_update: None, is_pending_window_update: false, reset_at: None, next_reset_expire: None, pending_recv: Deque { indices: None }, recv_task: None, pending_push_promises: Queue { indices: None, _p: PhantomData }, content_length: Omitted } | |
TRCE [ 0.039414s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: HalfClosedLocal(AwaitingHeaders) }; is_closed=false; pending_send_empty=false; buffered_send_data=1432; num_recv=0; num_send=1 | |
TRCE [ 0.039435s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.039440s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.039458s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll; bytes=9B | |
TRCE [ 0.039462s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read decoding frame from 9B | |
TRCE [ 0.039465s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read -> kind=Settings | |
DBUG [ 0.039470s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read received; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 0.039475s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x1: ACK) } | |
DBUG [ 0.039480s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings received remote settings ack | |
TRCE [ 0.039483s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.039487s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.039498s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.039503s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize poll_complete | |
TRCE [ 0.039507s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 0.039511s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame | |
TRCE [ 0.039515s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame; stream=StreamId(1); stream.state=State { inner: HalfClosedLocal(AwaitingHeaders) } | |
TRCE [ 0.039520s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize --> stream=StreamId(1); is_pending_reset=false; | |
TRCE [ 0.039525s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 0.039530s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store Queue::push | |
TRCE [ 0.039534s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store -> first entry | |
TRCE [ 0.039538s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: HalfClosedLocal(AwaitingHeaders) }; is_closed=false; pending_send_empty=false; buffered_send_data=1432; num_recv=0; num_send=1 | |
TRCE [ 0.039543s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize writing frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
DBUG [ 0.039547s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write send; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 0.039566s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.039570s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 0.039574s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame | |
TRCE [ 0.039577s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame; stream=StreamId(1); stream.state=State { inner: HalfClosedLocal(AwaitingHeaders) } | |
TRCE [ 0.039582s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize --> stream=StreamId(1); is_pending_reset=false; | |
TRCE [ 0.039586s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize --> data frame; stream=StreamId(1); sz=1432; eos=false; window=1432; available=1432; requested=1432; buffered=1432; | |
TRCE [ 0.039591s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize --> sending data frame; len=1432 | |
TRCE [ 0.039595s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize -- updating stream flow -- | |
TRCE [ 0.039599s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control send_data; sz=1432; window=65535; available=1432 | |
TRCE [ 0.039604s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize -- updating connection flow -- | |
TRCE [ 0.039608s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control send_data; sz=1432; window=65535; available=65535 | |
TRCE [ 0.039612s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 0.039616s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store Queue::push | |
TRCE [ 0.039620s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::store -> first entry | |
TRCE [ 0.039624s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: HalfClosedLocal(AwaitingHeaders) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=0; num_send=1 | |
TRCE [ 0.039629s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize writing frame=Data { stream_id: StreamId(1) } | |
DBUG [ 0.039633s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write send; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 0.039638s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flush | |
TRCE [ 0.039642s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write -> queued data frame | |
TRCE [ 0.039679s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write -> queued data frame | |
TRCE [ 0.039733s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flushing buffer | |
TRCE [ 0.039739s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.039742s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize -> reclaimed; frame=Data { stream_id: StreamId(1) }; sz=0 | |
TRCE [ 0.039748s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 0.039752s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame | |
TRCE [ 0.039756s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame; stream=StreamId(1); stream.state=State { inner: HalfClosedLocal(AwaitingHeaders) } | |
TRCE [ 0.039761s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize --> stream=StreamId(1); is_pending_reset=false; | |
TRCE [ 0.039765s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize --> data frame; stream=StreamId(1); sz=0; eos=true; window=0; available=0; requested=0; buffered=0; | |
TRCE [ 0.039770s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize --> sending data frame; len=0 | |
TRCE [ 0.039775s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize -- updating stream flow -- | |
TRCE [ 0.039780s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control send_data; sz=0; window=64103; available=0 | |
TRCE [ 0.039784s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize -- updating connection flow -- | |
TRCE [ 0.039787s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control send_data; sz=0; window=64103; available=64103 | |
TRCE [ 0.039792s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame; frame=Data { stream_id: StreamId(1), flags: (0x1: END_STREAM) } | |
TRCE [ 0.039797s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: HalfClosedLocal(AwaitingHeaders) }; is_closed=false; pending_send_empty=true; buffered_send_data=0; num_recv=0; num_send=1 | |
TRCE [ 0.039802s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize writing frame=Data { stream_id: StreamId(1), flags: (0x1: END_STREAM) } | |
DBUG [ 0.039807s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write send; frame=Data { stream_id: StreamId(1), flags: (0x1: END_STREAM) } | |
TRCE [ 0.039813s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.039817s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize -> reclaimed; frame=Data { stream_id: StreamId(1), flags: (0x1: END_STREAM) }; sz=0 | |
TRCE [ 0.039845s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 0.039850s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame | |
TRCE [ 0.039854s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flush | |
TRCE [ 0.039858s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 0.039890s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flushing buffer | |
TRCE [ 0.039896s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.049668s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.049691s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.049751s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll; bytes=47B | |
TRCE [ 0.049755s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read decoding frame from 47B | |
TRCE [ 0.049759s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read -> kind=Headers | |
TRCE [ 0.049764s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::frame::headers loading headers; flags=(0x4: END_HEADERS) | |
TRCE [ 0.049771s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::hpack::decoder decode | |
TRCE [ 0.049775s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::hpack::decoder Indexed; rem=38 | |
TRCE [ 0.049782s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::hpack::decoder LiteralWithIndexing; rem=37 | |
TRCE [ 0.049794s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::hpack::decoder LiteralWithIndexing; rem=24 | |
DBUG [ 0.049803s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read received; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 0.049810s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::connection recv HEADERS; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 0.049819s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::streams recv_headers; stream=StreamId(1); state=State { inner: HalfClosedLocal(AwaitingHeaders) } | |
TRCE [ 0.049866s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::recv opening stream; init_window=65535 | |
TRCE [ 0.049876s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: HalfClosedLocal(Streaming) }; is_closed=false; pending_send_empty=true; buffered_send_data=0; num_recv=0; num_send=1 | |
TRCE [ 0.049883s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.049887s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.049891s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll; bytes=946B | |
TRCE [ 0.049895s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read decoding frame from 946B | |
TRCE [ 0.049899s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read -> kind=Data | |
DBUG [ 0.049904s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read received; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 0.049908s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::connection recv DATA; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 0.049915s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::recv recv_data; size=937; connection=65535; stream=65535 | |
TRCE [ 0.049925s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control send_data; sz=937; window=65535; available=65535 | |
TRCE [ 0.049929s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::flow_control send_data; sz=937; window=65535; available=65535 | |
TRCE [ 0.049935s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: HalfClosedLocal(Streaming) }; is_closed=false; pending_send_empty=true; buffered_send_data=0; num_recv=0; num_send=1 | |
TRCE [ 0.049940s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.049944s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.049948s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll; bytes=33B | |
TRCE [ 0.049951s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read decoding frame from 33B | |
TRCE [ 0.049955s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read -> kind=Headers | |
TRCE [ 0.049959s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::frame::headers loading headers; flags=(0x5: END_HEADERS | END_STREAM) | |
TRCE [ 0.049963s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::hpack::decoder decode | |
TRCE [ 0.049967s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::hpack::decoder LiteralWithIndexing; rem=24 | |
TRCE [ 0.049984s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::hpack::decoder LiteralWithIndexing; rem=12 | |
DBUG [ 0.049991s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read received; frame=Headers { stream_id: StreamId(1), flags: (0x5: END_HEADERS | END_STREAM) } | |
TRCE [ 0.049997s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::connection recv HEADERS; frame=Headers { stream_id: StreamId(1), flags: (0x5: END_HEADERS | END_STREAM) } | |
TRCE [ 0.050002s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::streams recv_headers; stream=StreamId(1); state=State { inner: HalfClosedLocal(Streaming) } | |
TRCE [ 0.050007s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::state recv_close: HalfClosedLocal => Closed | |
TRCE [ 0.050013s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(EndStream) }; is_closed=true; pending_send_empty=true; buffered_send_data=0; num_recv=0; num_send=1 | |
TRCE [ 0.050019s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts dec_num_streams; stream=StreamId(1) | |
TRCE [ 0.050023s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.050027s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.050142s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.050149s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize poll_complete | |
TRCE [ 0.050153s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 0.050157s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame | |
TRCE [ 0.050161s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flush | |
TRCE [ 0.050165s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flushing buffer | |
TRCE [ 0.050169s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.050188s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::streams drop_stream_ref; stream=Stream { id: StreamId(1), state: State { inner: Closed(EndStream) }, is_counted: false, ref_count: 2, next_pending_send: None, is_pending_send: false, send_flow: FlowControl { window_size: Window(64103), available: Window(0) }, requested_send_capacity: 0, buffered_send_data: 0, send_task: Some(Task), pending_send: Deque { indices: None }, next_pending_send_capacity: None, is_pending_send_capacity: false, send_capacity_inc: true, next_open: None, is_pending_open: false, next_pending_accept: None, is_pending_accept: false, recv_flow: FlowControl { window_size: Window(64598), available: Window(64598) }, in_flight_recv_data: 937, next_window_update: None, is_pending_window_update: false, reset_at: None, next_reset_expire: None, pending_recv: Deque { indices: Some(Indices { head: 1, tail: 2 }) }, recv_task: None, pending_push_promises: Queue { indices: None, _p: PhantomData }, content_length: Omitted } | |
TRCE [ 0.050210s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(EndStream) }; is_closed=true; pending_send_empty=true; buffered_send_data=0; num_recv=0; num_send=0 | |
TRCE [ 0.050277s] admin={bg=identity} h2::proto::streams::recv release_capacity; size=937 | |
TRCE [ 0.050283s] admin={bg=identity} h2::proto::streams::recv release_connection_capacity; size=937, connection in_flight_data=937 | |
TRCE [ 0.050590s] admin={bg=identity} h2::proto::streams::streams drop_stream_ref; stream=Stream { id: StreamId(1), state: State { inner: Closed(EndStream) }, is_counted: false, ref_count: 1, next_pending_send: None, is_pending_send: false, send_flow: FlowControl { window_size: Window(64103), available: Window(0) }, requested_send_capacity: 0, buffered_send_data: 0, send_task: Some(Task), pending_send: Deque { indices: None }, next_pending_send_capacity: None, is_pending_send_capacity: false, send_capacity_inc: true, next_open: None, is_pending_open: false, next_pending_accept: None, is_pending_accept: false, recv_flow: FlowControl { window_size: Window(64598), available: Window(65535) }, in_flight_recv_data: 0, next_window_update: None, is_pending_window_update: false, reset_at: None, next_reset_expire: None, pending_recv: Deque { indices: None }, recv_task: None, pending_push_promises: Queue { indices: None, _p: PhantomData }, content_length: Omitted } | |
TRCE [ 0.050612s] admin={bg=identity} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(EndStream) }; is_closed=true; pending_send_empty=true; buffered_send_data=0; num_recv=0; num_send=0 | |
INFO [ 0.051329s] linkerd2_proxy::app::main Certified identity: grpc-ingress-nginx-ingress.grpc-ingress.serviceaccount.identity.linkerd.cluster.local | |
TRCE [ 0.051346s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 0.051352s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_read poll | |
TRCE [ 0.051377s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 0.051381s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize poll_complete | |
TRCE [ 0.051385s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 0.051389s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize pop_frame | |
TRCE [ 0.051392s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flush | |
TRCE [ 0.051396s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::codec::framed_write flushing buffer | |
TRCE [ 0.051400s] admin={client=control dst=linkerd-identity.linkerd.svc.cluster.local:8080 remote=10.11.249.66:8080} h2::proto::streams::prioritize try reclaim frame | |
DBUG [ 32.712116s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write send; frame=Settings { flags: (0x0) } | |
TRCE [ 32.712166s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 32.712171s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 32.712180s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::server Handshake::poll(); state=Handshaking::Flushing(_); | |
TRCE [ 32.712185s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write flush | |
TRCE [ 32.712188s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 32.712229s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write flushing buffer | |
TRCE [ 32.712237s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::server Handshake::poll(); flush.poll()=Ready | |
TRCE [ 32.712246s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 32.712249s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 32.712252s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize Prioritize::new; flow=FlowControl { window_size: Window(65535), available: Window(65535) } | |
TRCE [ 32.712260s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::server Handshake::poll(); connection established! | |
TRCE [ 32.712268s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.712272s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll | |
TRCE [ 32.712278s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll; bytes=27B | |
TRCE [ 32.712281s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read decoding frame from 27B | |
TRCE [ 32.712283s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read -> kind=Settings | |
DBUG [ 32.712288s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read received; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 32.712293s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 32.712297s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings send_pending_ack; pending=Some(Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 }) | |
DBUG [ 32.712301s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write send; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 32.712304s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 32.712306s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 32.712309s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings ACK sent; applying settings | |
TRCE [ 32.712312s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll | |
TRCE [ 32.712315s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll; bytes=13B | |
TRCE [ 32.712318s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read decoding frame from 13B | |
TRCE [ 32.712322s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read -> kind=WindowUpdate | |
DBUG [ 32.712326s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read received; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 32.712331s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::connection recv WINDOW_UPDATE; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 32.712335s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::flow_control inc_window; sz=2147418112; old=65535; new=2147483647 | |
TRCE [ 32.712338s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize assign_connection_capacity; inc=2147418112 | |
TRCE [ 32.712342s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.712357s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll | |
TRCE [ 32.712359s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll; bytes=382B | |
TRCE [ 32.712361s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read decoding frame from 382B | |
TRCE [ 32.712364s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read -> kind=Headers | |
TRCE [ 32.712367s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::frame::headers loading headers; flags=(0x4: END_HEADERS) | |
TRCE [ 32.712373s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder decode | |
TRCE [ 32.712376s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder Indexed; rem=373 | |
TRCE [ 32.712382s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder Indexed; rem=372 | |
TRCE [ 32.712389s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithIndexing; rem=371 | |
TRCE [ 32.712440s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=324 | |
TRCE [ 32.712458s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=286 | |
TRCE [ 32.712472s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=251 | |
TRCE [ 32.712476s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=234 | |
TRCE [ 32.712480s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=213 | |
TRCE [ 32.712485s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=166 | |
TRCE [ 32.712489s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=148 | |
TRCE [ 32.712495s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=128 | |
TRCE [ 32.712503s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=70 | |
TRCE [ 32.712507s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=57 | |
TRCE [ 32.712511s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=46 | |
TRCE [ 32.712520s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::hpack::decoder LiteralWithoutIndexing; rem=23 | |
DBUG [ 32.712524s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read received; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 32.712530s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::connection recv HEADERS; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 32.712538s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 32.712546s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::flow_control inc_window; sz=2147483647; old=0; new=2147483647 | |
TRCE [ 32.712552s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::streams recv_headers; stream=StreamId(1); state=State { inner: Idle } | |
TRCE [ 32.712560s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::recv opening stream; init_window=65535 | |
TRCE [ 32.712571s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::send send_reset(..., reason=PROTOCOL_ERROR, stream=StreamId(1), ..., is_reset=false; is_closed=false; pending_send.is_empty=true; state=State { inner: Open { local: AwaitingHeaders, remote: Streaming } } | |
TRCE [ 32.712581s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize clear_queue; stream=StreamId(1) | |
TRCE [ 32.712584s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::send send_reset -- queueing; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 32.712590s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize schedule_send; StreamId(1) | |
TRCE [ 32.712594s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::store Queue::push | |
TRCE [ 32.712597s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::store -> first entry | |
TRCE [ 32.712600s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize assign_connection_capacity; inc=0 | |
TRCE [ 32.712604s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 32.712611s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.712614s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll | |
TRCE [ 32.712618s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll; bytes=49B | |
TRCE [ 32.712626s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read decoding frame from 49B | |
TRCE [ 32.712629s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read -> kind=Data | |
DBUG [ 32.712633s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read received; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 32.712636s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::connection recv DATA; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 32.712646s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::recv recv_data; size=40; connection=65535; stream=65535 | |
TRCE [ 32.712649s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::flow_control send_data; sz=40; window=65535; available=65535 | |
TRCE [ 32.712653s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::recv recv_data frame ignored on locally reset StreamId(1) for some time | |
TRCE [ 32.712656s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::recv release_connection_capacity; size=40, connection in_flight_data=40 | |
TRCE [ 32.712660s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 32.712668s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.712671s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll | |
TRCE [ 32.712679s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll; bytes=9B | |
TRCE [ 32.712687s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read decoding frame from 9B | |
TRCE [ 32.712689s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read -> kind=Settings | |
DBUG [ 32.712692s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read received; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 32.712696s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x1: ACK) } | |
DBUG [ 32.712703s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings received remote settings ack | |
TRCE [ 32.712705s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.712708s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll | |
TRCE [ 32.712716s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 32.712724s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize poll_complete | |
TRCE [ 32.712727s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 32.712730s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize pop_frame | |
TRCE [ 32.712734s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize pop_frame; stream=StreamId(1); stream.state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) } | |
TRCE [ 32.712742s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize --> stream=StreamId(1); is_pending_reset=false; | |
TRCE [ 32.712746s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize pop_frame; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 32.712755s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=true; pending_send_empty=true; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 32.712759s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::counts dec_num_streams; stream=StreamId(1) | |
TRCE [ 32.712763s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize writing frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
DBUG [ 32.712770s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write send; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 32.712774s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::frame::reset encoding RESET; id=StreamId(1) code=PROTOCOL_ERROR | |
TRCE [ 32.712794s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write encoded reset; rem=22 | |
TRCE [ 32.712798s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 32.712802s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 32.712805s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize pop_frame | |
TRCE [ 32.712809s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write flush | |
TRCE [ 32.712812s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 32.712923s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write flushing buffer | |
TRCE [ 32.712934s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 32.713085s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.713094s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_read poll | |
TRCE [ 32.713101s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::connection codec closed | |
TRCE [ 32.713104s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::streams Streams::recv_eof | |
TRCE [ 32.713108s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::connection connection closing after flush | |
TRCE [ 32.713111s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write flush | |
TRCE [ 32.713113s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::codec::framed_write flushing buffer | |
TRCE [ 32.713173s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33606} h2::proto::streams::streams Streams::recv_eof | |
DBUG [ 32.745109s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write send; frame=Settings { flags: (0x0) } | |
TRCE [ 32.745162s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 32.745168s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 32.745177s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::server Handshake::poll(); state=Handshaking::Flushing(_); | |
TRCE [ 32.745181s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write flush | |
TRCE [ 32.745184s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 32.745221s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write flushing buffer | |
TRCE [ 32.745233s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::server Handshake::poll(); flush.poll()=Ready | |
TRCE [ 32.745244s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 32.745255s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 32.745257s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize Prioritize::new; flow=FlowControl { window_size: Window(65535), available: Window(65535) } | |
TRCE [ 32.745265s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::server Handshake::poll(); connection established! | |
TRCE [ 32.745278s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.745287s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll | |
TRCE [ 32.745292s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll; bytes=27B | |
TRCE [ 32.745295s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read decoding frame from 27B | |
TRCE [ 32.745298s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read -> kind=Settings | |
DBUG [ 32.745302s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read received; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 32.745311s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 32.745315s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::settings send_pending_ack; pending=Some(Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 }) | |
DBUG [ 32.745323s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write send; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 32.745326s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 32.745328s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 32.745331s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::settings ACK sent; applying settings | |
TRCE [ 32.745335s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll | |
TRCE [ 32.745341s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll; bytes=13B | |
TRCE [ 32.745344s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read decoding frame from 13B | |
TRCE [ 32.745347s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read -> kind=WindowUpdate | |
DBUG [ 32.745350s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read received; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 32.745354s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::connection recv WINDOW_UPDATE; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 32.745359s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::flow_control inc_window; sz=2147418112; old=65535; new=2147483647 | |
TRCE [ 32.745362s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize assign_connection_capacity; inc=2147418112 | |
TRCE [ 32.745366s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.745369s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll | |
TRCE [ 32.745372s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll; bytes=382B | |
TRCE [ 32.745376s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read decoding frame from 382B | |
TRCE [ 32.745379s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read -> kind=Headers | |
TRCE [ 32.745382s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::frame::headers loading headers; flags=(0x4: END_HEADERS) | |
TRCE [ 32.745387s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder decode | |
TRCE [ 32.745390s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder Indexed; rem=373 | |
TRCE [ 32.745395s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder Indexed; rem=372 | |
TRCE [ 32.745400s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithIndexing; rem=371 | |
TRCE [ 32.745413s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=324 | |
TRCE [ 32.745425s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=286 | |
TRCE [ 32.745437s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=251 | |
TRCE [ 32.745441s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=234 | |
TRCE [ 32.745487s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=213 | |
TRCE [ 32.745496s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=166 | |
TRCE [ 32.745503s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=148 | |
TRCE [ 32.745510s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=128 | |
TRCE [ 32.745515s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=70 | |
TRCE [ 32.745521s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=57 | |
TRCE [ 32.745525s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=46 | |
TRCE [ 32.745530s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::hpack::decoder LiteralWithoutIndexing; rem=23 | |
DBUG [ 32.745539s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read received; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 32.745545s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::connection recv HEADERS; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 32.745552s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 32.745560s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::flow_control inc_window; sz=2147483647; old=0; new=2147483647 | |
TRCE [ 32.745565s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::streams recv_headers; stream=StreamId(1); state=State { inner: Idle } | |
TRCE [ 32.745574s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::recv opening stream; init_window=65535 | |
TRCE [ 32.745583s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::send send_reset(..., reason=PROTOCOL_ERROR, stream=StreamId(1), ..., is_reset=false; is_closed=false; pending_send.is_empty=true; state=State { inner: Open { local: AwaitingHeaders, remote: Streaming } } | |
TRCE [ 32.745590s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize clear_queue; stream=StreamId(1) | |
TRCE [ 32.745595s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::send send_reset -- queueing; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 32.745600s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize schedule_send; StreamId(1) | |
TRCE [ 32.745606s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::store Queue::push | |
TRCE [ 32.745608s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::store -> first entry | |
TRCE [ 32.745613s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize assign_connection_capacity; inc=0 | |
TRCE [ 32.745616s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 32.745627s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.745631s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll | |
TRCE [ 32.745634s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll; bytes=49B | |
TRCE [ 32.745636s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read decoding frame from 49B | |
TRCE [ 32.745639s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read -> kind=Data | |
DBUG [ 32.745643s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read received; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 32.745647s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::connection recv DATA; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 32.745665s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::recv recv_data; size=40; connection=65535; stream=65535 | |
TRCE [ 32.745673s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::flow_control send_data; sz=40; window=65535; available=65535 | |
TRCE [ 32.745675s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::recv recv_data frame ignored on locally reset StreamId(1) for some time | |
TRCE [ 32.745678s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::recv release_connection_capacity; size=40, connection in_flight_data=40 | |
TRCE [ 32.745682s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 32.745687s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.745689s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll | |
TRCE [ 32.745699s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 32.745706s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize poll_complete | |
TRCE [ 32.745709s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 32.745712s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize pop_frame | |
TRCE [ 32.745715s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize pop_frame; stream=StreamId(1); stream.state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) } | |
TRCE [ 32.745724s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize --> stream=StreamId(1); is_pending_reset=false; | |
TRCE [ 32.745728s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize pop_frame; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 32.745737s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=true; pending_send_empty=true; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 32.745741s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::counts dec_num_streams; stream=StreamId(1) | |
TRCE [ 32.745745s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize writing frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
DBUG [ 32.745754s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write send; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 32.745758s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::frame::reset encoding RESET; id=StreamId(1) code=PROTOCOL_ERROR | |
TRCE [ 32.745762s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write encoded reset; rem=22 | |
TRCE [ 32.745770s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 32.745772s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 32.745774s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize pop_frame | |
TRCE [ 32.745777s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write flush | |
TRCE [ 32.745779s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 32.745809s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write flushing buffer | |
TRCE [ 32.745819s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 32.746870s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 32.746887s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_read poll | |
TRCE [ 32.746898s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::connection codec closed | |
TRCE [ 32.746901s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::streams Streams::recv_eof | |
TRCE [ 32.746919s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::connection connection closing after flush | |
TRCE [ 32.746929s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write flush | |
TRCE [ 32.746931s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::codec::framed_write flushing buffer | |
TRCE [ 32.746986s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33608} h2::proto::streams::streams Streams::recv_eof | |
DBUG [ 76.896623s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write send; frame=Settings { flags: (0x0) } | |
TRCE [ 76.896665s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 76.896670s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 76.896684s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::server Handshake::poll(); state=Handshaking::Flushing(_); | |
TRCE [ 76.896688s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write flush | |
TRCE [ 76.896691s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 76.896727s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write flushing buffer | |
TRCE [ 76.896742s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::server Handshake::poll(); flush.poll()=Ready | |
TRCE [ 76.896757s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 76.896766s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 76.896769s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize Prioritize::new; flow=FlowControl { window_size: Window(65535), available: Window(65535) } | |
TRCE [ 76.896777s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::server Handshake::poll(); connection established! | |
TRCE [ 76.896789s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.896798s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll | |
TRCE [ 76.896805s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll; bytes=27B | |
TRCE [ 76.896812s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read decoding frame from 27B | |
TRCE [ 76.896815s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read -> kind=Settings | |
DBUG [ 76.896836s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read received; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 76.896849s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 76.896854s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::settings send_pending_ack; pending=Some(Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 }) | |
DBUG [ 76.896863s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write send; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 76.896867s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 76.896870s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 76.896874s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::settings ACK sent; applying settings | |
TRCE [ 76.896884s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll | |
TRCE [ 76.896888s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll; bytes=13B | |
TRCE [ 76.896892s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read decoding frame from 13B | |
TRCE [ 76.896895s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read -> kind=WindowUpdate | |
DBUG [ 76.896899s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read received; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 76.896909s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::connection recv WINDOW_UPDATE; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 76.896919s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::flow_control inc_window; sz=2147418112; old=65535; new=2147483647 | |
TRCE [ 76.896923s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize assign_connection_capacity; inc=2147418112 | |
TRCE [ 76.896926s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.896929s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll | |
TRCE [ 76.896933s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll; bytes=382B | |
TRCE [ 76.896941s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read decoding frame from 382B | |
TRCE [ 76.896945s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read -> kind=Headers | |
TRCE [ 76.896948s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::frame::headers loading headers; flags=(0x4: END_HEADERS) | |
TRCE [ 76.896958s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder decode | |
TRCE [ 76.896961s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder Indexed; rem=373 | |
TRCE [ 76.896966s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder Indexed; rem=372 | |
TRCE [ 76.896970s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithIndexing; rem=371 | |
TRCE [ 76.896988s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=324 | |
TRCE [ 76.896997s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=286 | |
TRCE [ 76.897004s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=251 | |
TRCE [ 76.897009s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=234 | |
TRCE [ 76.897018s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=213 | |
TRCE [ 76.897023s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=166 | |
TRCE [ 76.897031s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=148 | |
TRCE [ 76.897038s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=128 | |
TRCE [ 76.897047s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=70 | |
TRCE [ 76.897050s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=57 | |
TRCE [ 76.897055s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=46 | |
TRCE [ 76.897058s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::hpack::decoder LiteralWithoutIndexing; rem=23 | |
DBUG [ 76.897068s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read received; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 76.897078s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::connection recv HEADERS; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 76.897084s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 76.897087s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::flow_control inc_window; sz=2147483647; old=0; new=2147483647 | |
TRCE [ 76.897092s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::streams recv_headers; stream=StreamId(1); state=State { inner: Idle } | |
TRCE [ 76.897101s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::recv opening stream; init_window=65535 | |
TRCE [ 76.897111s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::send send_reset(..., reason=PROTOCOL_ERROR, stream=StreamId(1), ..., is_reset=false; is_closed=false; pending_send.is_empty=true; state=State { inner: Open { local: AwaitingHeaders, remote: Streaming } } | |
TRCE [ 76.897122s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize clear_queue; stream=StreamId(1) | |
TRCE [ 76.897126s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::send send_reset -- queueing; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 76.897136s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize schedule_send; StreamId(1) | |
TRCE [ 76.897140s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::store Queue::push | |
TRCE [ 76.897143s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::store -> first entry | |
TRCE [ 76.897151s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize assign_connection_capacity; inc=0 | |
TRCE [ 76.897155s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 76.897165s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.897168s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll | |
TRCE [ 76.897171s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll; bytes=49B | |
TRCE [ 76.897174s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read decoding frame from 49B | |
TRCE [ 76.897177s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read -> kind=Data | |
DBUG [ 76.897180s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read received; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 76.897185s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::connection recv DATA; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 76.897194s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::recv recv_data; size=40; connection=65535; stream=65535 | |
TRCE [ 76.897197s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::flow_control send_data; sz=40; window=65535; available=65535 | |
TRCE [ 76.897200s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::recv recv_data frame ignored on locally reset StreamId(1) for some time | |
TRCE [ 76.897203s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::recv release_connection_capacity; size=40, connection in_flight_data=40 | |
TRCE [ 76.897207s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 76.897216s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.897219s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll | |
TRCE [ 76.897228s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 76.897236s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize poll_complete | |
TRCE [ 76.897239s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 76.897242s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize pop_frame | |
TRCE [ 76.897251s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize pop_frame; stream=StreamId(1); stream.state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) } | |
TRCE [ 76.897255s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize --> stream=StreamId(1); is_pending_reset=false; | |
TRCE [ 76.897260s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize pop_frame; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 76.897268s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=true; pending_send_empty=true; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 76.897272s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::counts dec_num_streams; stream=StreamId(1) | |
TRCE [ 76.897276s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize writing frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
DBUG [ 76.897283s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write send; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 76.897287s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::frame::reset encoding RESET; id=StreamId(1) code=PROTOCOL_ERROR | |
TRCE [ 76.897292s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write encoded reset; rem=22 | |
TRCE [ 76.897299s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 76.897301s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 76.897304s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize pop_frame | |
TRCE [ 76.897307s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write flush | |
TRCE [ 76.897310s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 76.897336s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write flushing buffer | |
TRCE [ 76.897345s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 76.898009s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.898030s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_read poll | |
TRCE [ 76.898038s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::connection codec closed | |
TRCE [ 76.898041s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::streams Streams::recv_eof | |
TRCE [ 76.898047s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::connection connection closing after flush | |
TRCE [ 76.898057s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write flush | |
TRCE [ 76.898060s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::codec::framed_write flushing buffer | |
TRCE [ 76.898102s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33802} h2::proto::streams::streams Streams::recv_eof | |
DBUG [ 76.923592s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write send; frame=Settings { flags: (0x0) } | |
TRCE [ 76.923641s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 76.923692s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 76.923739s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::server Handshake::poll(); state=Handshaking::Flushing(_); | |
TRCE [ 76.923772s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write flush | |
TRCE [ 76.923794s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 76.923886s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write flushing buffer | |
TRCE [ 76.923927s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::server Handshake::poll(); flush.poll()=Ready | |
TRCE [ 76.923993s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 76.924019s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 76.924049s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize Prioritize::new; flow=FlowControl { window_size: Window(65535), available: Window(65535) } | |
TRCE [ 76.924080s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::server Handshake::poll(); connection established! | |
TRCE [ 76.924153s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.924183s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll | |
TRCE [ 76.924204s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll; bytes=27B | |
TRCE [ 76.924250s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read decoding frame from 27B | |
TRCE [ 76.924319s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read -> kind=Settings | |
DBUG [ 76.924338s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read received; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 76.924354s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 } | |
TRCE [ 76.924383s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings send_pending_ack; pending=Some(Settings { flags: (0x0), header_table_size: 0, enable_push: 0, initial_window_size: 2147483647 }) | |
DBUG [ 76.924403s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write send; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 76.924417s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::frame::settings encoding SETTINGS; len=0 | |
TRCE [ 76.924429s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write encoded settings; rem=9 | |
TRCE [ 76.924443s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings ACK sent; applying settings | |
TRCE [ 76.924461s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll | |
TRCE [ 76.924589s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll; bytes=13B | |
TRCE [ 76.924630s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read decoding frame from 13B | |
TRCE [ 76.924650s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read -> kind=WindowUpdate | |
DBUG [ 76.924715s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read received; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 76.924737s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::connection recv WINDOW_UPDATE; frame=WindowUpdate { stream_id: StreamId(0), size_increment: 2147418112 } | |
TRCE [ 76.924742s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::flow_control inc_window; sz=2147418112; old=65535; new=2147483647 | |
TRCE [ 76.924748s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize assign_connection_capacity; inc=2147418112 | |
TRCE [ 76.924752s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.924755s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll | |
TRCE [ 76.924758s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll; bytes=382B | |
TRCE [ 76.924761s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read decoding frame from 382B | |
TRCE [ 76.924763s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read -> kind=Headers | |
TRCE [ 76.924766s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::frame::headers loading headers; flags=(0x4: END_HEADERS) | |
TRCE [ 76.924773s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder decode | |
TRCE [ 76.924809s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder Indexed; rem=373 | |
TRCE [ 76.925044s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder Indexed; rem=372 | |
TRCE [ 76.925118s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithIndexing; rem=371 | |
TRCE [ 76.925261s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=324 | |
TRCE [ 76.925287s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=286 | |
TRCE [ 76.925294s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=251 | |
TRCE [ 76.925301s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=234 | |
TRCE [ 76.925308s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=213 | |
TRCE [ 76.925312s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=166 | |
TRCE [ 76.925316s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=148 | |
TRCE [ 76.925408s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=128 | |
TRCE [ 76.925428s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=70 | |
TRCE [ 76.925433s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=57 | |
TRCE [ 76.925473s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=46 | |
TRCE [ 76.925513s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::hpack::decoder LiteralWithoutIndexing; rem=23 | |
DBUG [ 76.925558s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read received; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 76.925619s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::connection recv HEADERS; frame=Headers { stream_id: StreamId(1), flags: (0x4: END_HEADERS) } | |
TRCE [ 76.925704s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::flow_control inc_window; sz=65535; old=0; new=65535 | |
TRCE [ 76.925737s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::flow_control inc_window; sz=2147483647; old=0; new=2147483647 | |
TRCE [ 76.925748s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::streams recv_headers; stream=StreamId(1); state=State { inner: Idle } | |
TRCE [ 76.925757s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::recv opening stream; init_window=65535 | |
TRCE [ 76.925771s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::send send_reset(..., reason=PROTOCOL_ERROR, stream=StreamId(1), ..., is_reset=false; is_closed=false; pending_send.is_empty=true; state=State { inner: Open { local: AwaitingHeaders, remote: Streaming } } | |
TRCE [ 76.925786s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize clear_queue; stream=StreamId(1) | |
TRCE [ 76.925798s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::send send_reset -- queueing; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 76.925863s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize schedule_send; StreamId(1) | |
TRCE [ 76.925901s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::store Queue::push | |
TRCE [ 76.925946s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::store -> first entry | |
TRCE [ 76.925987s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize assign_connection_capacity; inc=0 | |
TRCE [ 76.926070s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 76.926122s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.926163s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll | |
TRCE [ 76.926191s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll; bytes=49B | |
TRCE [ 76.926215s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read decoding frame from 49B | |
TRCE [ 76.926234s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read -> kind=Data | |
DBUG [ 76.926247s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read received; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 76.926285s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::connection recv DATA; frame=Data { stream_id: StreamId(1) } | |
TRCE [ 76.926341s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::recv recv_data; size=40; connection=65535; stream=65535 | |
TRCE [ 76.926367s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::flow_control send_data; sz=40; window=65535; available=65535 | |
TRCE [ 76.926381s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::recv recv_data frame ignored on locally reset StreamId(1) for some time | |
TRCE [ 76.926396s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::recv release_connection_capacity; size=40, connection in_flight_data=40 | |
TRCE [ 76.926410s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=false; pending_send_empty=false; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 76.926433s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.926466s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll | |
TRCE [ 76.926495s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll; bytes=9B | |
TRCE [ 76.926571s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read decoding frame from 9B | |
TRCE [ 76.926592s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read -> kind=Settings | |
DBUG [ 76.926605s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read received; frame=Settings { flags: (0x1: ACK) } | |
TRCE [ 76.926618s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::connection recv SETTINGS; frame=Settings { flags: (0x1: ACK) } | |
DBUG [ 76.926649s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings received remote settings ack | |
TRCE [ 76.926694s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.926710s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll | |
TRCE [ 76.926725s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 76.926737s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize poll_complete | |
TRCE [ 76.926869s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 76.926894s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize pop_frame | |
TRCE [ 76.926911s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize pop_frame; stream=StreamId(1); stream.state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) } | |
TRCE [ 76.926931s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize --> stream=StreamId(1); is_pending_reset=false; | |
TRCE [ 76.926999s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize pop_frame; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 76.927074s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::counts transition_after; stream=StreamId(1); state=State { inner: Closed(LocallyReset(PROTOCOL_ERROR)) }; is_closed=true; pending_send_empty=true; buffered_send_data=0; num_recv=1; num_send=0 | |
TRCE [ 76.927110s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::counts dec_num_streams; stream=StreamId(1) | |
TRCE [ 76.927143s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize writing frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
DBUG [ 76.927221s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write send; frame=Reset { stream_id: StreamId(1), error_code: PROTOCOL_ERROR } | |
TRCE [ 76.927260s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::frame::reset encoding RESET; id=StreamId(1) code=PROTOCOL_ERROR | |
TRCE [ 76.927286s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write encoded reset; rem=22 | |
TRCE [ 76.927350s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 76.927364s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize schedule_pending_open | |
TRCE [ 76.927367s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize pop_frame | |
TRCE [ 76.927375s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write flush | |
TRCE [ 76.927378s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write -> not a queued data frame | |
TRCE [ 76.927427s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write flushing buffer | |
TRCE [ 76.927516s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::prioritize try reclaim frame | |
TRCE [ 76.927865s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::settings send_pending_ack; pending=None | |
TRCE [ 76.928050s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_read poll | |
TRCE [ 76.928141s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::connection codec closed | |
TRCE [ 76.928227s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::streams Streams::recv_eof | |
TRCE [ 76.928309s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::connection connection closing after flush | |
TRCE [ 76.928327s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write flush | |
TRCE [ 76.928330s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::codec::framed_write flushing buffer | |
TRCE [ 76.928632s] proxy={server=out listen=127.0.0.1:4140 remote=10.8.29.40:33806} h2::proto::streams::streams Streams::recv_eof |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment