0.046448984s s2n_quic:client: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.046578957s s2n_quic:client: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.046595007s s2n_quic:client: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.046605005s s2n_quic:client: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.046616497s s2n_quic:client: platform_feature_configured: configuration=Gro { enabled: true } 0.046633629s s2n_quic:client: platform_feature_configured: configuration=Ecn { enabled: true } 0.048000683s s2n_quic:client: platform_event_loop_started: local_address=[::]:38815 0.048093386s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.048122370s s2n_quic:client: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.048161714s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=69µs 0.048902357s s2n_quic:client:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.048980212s s2n_quic:client:conn: connection_started: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x974a4d453f40b2d7, id: 0, is_active: true } id=0 0.049007714s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 0.049167743s s2n_quic:client:conn: server_name_information: chosen_server_name="server6" id=0 0.049263392s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.049391781s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 287 } id=0 0.049428139s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.049504853s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=1232 id=0 0.049528046s s2n_quic:client:conn: datagram_sent: len=1232 gso_offset=0 id=0 0.049569533s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x974a4d453f40b2d7, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=0ns pto_count=0 congestion_window=12320 bytes_in_flight=1232 congestion_limited=false id=0 0.049630978s s2n_quic:client: platform_event_loop_sleep: timeout=Some(998.659ms) processing_duration=367µs 0.092505697s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.092565028s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.092580607s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.092662980s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.092712663s s2n_quic:client:conn: packet_received: packet_header=Initial { number: 0, version: 1 } id=0 0.092748941s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x974a4d453f40b2d7, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 0.092791451s s2n_quic:client:conn: ack_range_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x974a4d453f40b2d7, id: 0, is_active: true } ack_range=0..=0 id=0 0.092827388s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1232 cause=InitialMtuPacketAcknowledged search_complete=false id=0 0.092874916s s2n_quic:client:conn: pacing_rate_updated: path_id=0 bytes_per_second=779970 burst_size=12320 pacing_gain=2.77 id=0 0.092917376s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 43.316ms, delivered_bytes: 1232, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 28442 } id=0 0.092948013s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x974a4d453f40b2d7, id: 0, is_active: true } min_rtt=43.316ms smoothed_rtt=43.316ms latest_rtt=43.316ms rtt_variance=21.658ms max_ack_delay=0ns pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 0.092978089s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x974a4d453f40b2d7, id: 0, is_active: true } frame=Crypto { offset: 0, len: 123 } id=0 0.093028473s s2n_quic:client:conn: tls_server_hello: payload=[[3, 3, 195, 169, 116, 214, 156, 161, 7, 164, 118, 171, 59, 153, 93, 67, 20, 14, 47, 252, 86, 194, 128, 20, 103, 219, 148, 235, 156, 243, 199, 26, 15, 197, 0, 19, 1, 0, 0, 79, 0, 51, 0, 69, 0, 23, 0, 65, 4, 218, 76, 64, 60, 65, 125, 38, 193, 233, 176, 96, 145, 246, 200, 82, 15, 88, 34, 199, 57, 54, 48, 170, 6, 162, 12, 43, 184, 232, 155, 85, 42, 200, 126, 223, 183, 82, 72, 228, 68, 146, 26, 222, 61, 31, 139, 52, 101, 208, 145, 219, 125, 205, 11, 223, 44, 221, 65, 190, 173, 112, 173, 113, 72, 0, 43, 0, 2, 3, 4]] id=0 0.093333393s s2n_quic:client:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.093464838s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 0, version: 1 } id=0 0.093513780s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } frame=Crypto { offset: 0, len: 725 } id=0 0.093985130s s2n_quic:client:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 0.094017651s s2n_quic:client:conn: key_exchange_group: chosen_group_name="secp256r1" contains_kem=false id=0 0.094058487s s2n_quic:client:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: Some(0x974a4d453f40b2d7), initial_source_connection_id: Some(0xbff9fdbbcecdcd763030), retry_source_connection_id: None, stateless_reset_token: None, preferred_address: None, migration_support: true, max_idle_timeout: 30s, ack_delay_exponent: 3, max_ack_delay: 20ms, max_udp_payload_size: 65527, active_connection_id_limit: 8, initial_max_stream_data_bidi_local: 1048576, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 1048576, initial_max_streams_bidi: 16, initial_max_streams_uni: 16, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 0.094130682s s2n_quic:client:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.094218917s s2n_quic:client:conn: handshake_status_updated: status=Complete id=0 0.094247901s s2n_quic:client:conn: tls_exporter_ready: session=TlsSession { .. } id=0 0.094272467s s2n_quic:client:conn: packet_dropped: reason=DecodingFailed { path: Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } } id=0 0.094401498s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 0.094459396s s2n_quic:client:conn: ack_range_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 ack_range=0..=0 id=0 0.094484714s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Padding id=0 0.094514379s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 1, version: 1 } packet_len=72 id=0 0.094541650s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 0.094557209s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 0.094577567s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 36 } id=0 0.094600290s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.094650433s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1160 id=0 0.094668637s s2n_quic:client:conn: key_space_discarded: space=Initial id=0 0.094681161s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } min_rtt=43.316ms smoothed_rtt=43.316ms latest_rtt=43.316ms rtt_variance=21.658ms max_ack_delay=20ms pto_count=0 congestion_window=13552 bytes_in_flight=1160 congestion_limited=false id=0 0.094756662s s2n_quic:client:conn: datagram_sent: len=1232 gso_offset=0 id=0 0.094797288s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } min_rtt=43.316ms smoothed_rtt=43.316ms latest_rtt=43.316ms rtt_variance=21.658ms max_ack_delay=20ms pto_count=0 congestion_window=13552 bytes_in_flight=1160 congestion_limited=false id=0 0.094860085s s2n_quic:client: platform_event_loop_sleep: timeout=Some(129.442ms) processing_duration=2.362ms 0.095352375s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.095397479s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.095493378s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 4, offset: 0, len: 0, is_fin: false } id=0 0.095540857s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 0.095566655s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 4, offset: 0, len: 17, is_fin: true } id=0 0.095614835s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=71 id=0 0.095634071s s2n_quic:client:conn: datagram_sent: len=71 gso_offset=0 id=0 0.095671461s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } min_rtt=43.316ms smoothed_rtt=43.316ms latest_rtt=43.316ms rtt_variance=21.658ms max_ack_delay=20ms pto_count=0 congestion_window=13552 bytes_in_flight=1231 congestion_limited=false id=0 0.095705955s s2n_quic:client:conn: tx_stream_progress: bytes=34 id=0 0.095738897s s2n_quic:client: platform_event_loop_sleep: timeout=Some(128.563ms) processing_duration=388µs 0.128022898s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.128065909s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.128079875s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.128126612s s2n_quic:client:conn: datagram_received: len=1332 id=0 0.128165535s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 1, version: 1 } id=0 0.128189970s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 0.128225326s s2n_quic:client:conn: ack_range_received: packet_header=Handshake { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } ack_range=0..=0 id=0 0.128277874s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.75ms, delivered_bytes: 1160, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1160, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 34370 } id=0 0.128311257s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } min_rtt=33.75ms smoothed_rtt=43.316ms latest_rtt=33.75ms rtt_variance=21.658ms max_ack_delay=20ms pto_count=0 congestion_window=14712 bytes_in_flight=71 congestion_limited=false id=0 0.128378052s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 0 } id=0 0.128400534s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } frame=HandshakeDone id=0 0.128422715s s2n_quic:client:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 0.128455707s s2n_quic:client:conn: handshake_status_updated: status=Confirmed id=0 0.128485202s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xbff9fdbbcecdcd763030, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 0.128544803s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0xbff9fdbbcecdcd763030 current=0x5711604123a3c979928d id=0 0.128569750s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 0.128622438s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Padding id=0 0.128667272s s2n_quic:client:conn: key_space_discarded: space=Handshake id=0 0.128682020s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=33.75ms smoothed_rtt=43.316ms latest_rtt=33.75ms rtt_variance=21.658ms max_ack_delay=20ms pto_count=0 congestion_window=14712 bytes_in_flight=71 congestion_limited=false id=0 0.128816811s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ping id=0 0.128851737s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Padding id=0 0.128884017s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=1452 id=0 0.128899145s s2n_quic:client:conn: datagram_sent: len=1452 gso_offset=0 id=0 0.128936295s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 0.128955090s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 2 } path_id=0 ack_range=0..=0 id=0 0.128975067s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=NewConnectionId { sequence_number: 1, retire_prior_to: 1 } id=0 0.128988712s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=NewConnectionId { sequence_number: 2, retire_prior_to: 1 } id=0 0.129001266s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 0.129018147s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=RetireConnectionId id=0 0.129059124s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=147 id=0 0.129077288s s2n_quic:client:conn: datagram_sent: len=147 gso_offset=0 id=0 0.129110119s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=33.75ms smoothed_rtt=43.316ms latest_rtt=33.75ms rtt_variance=21.658ms max_ack_delay=20ms pto_count=0 congestion_window=14712 bytes_in_flight=1670 congestion_limited=false id=0 0.129163829s s2n_quic:client: platform_event_loop_sleep: timeout=Some(149.581ms) processing_duration=1.144ms 0.129283363s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.129309762s s2n_quic:client: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.129327686s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.129360958s s2n_quic:client:conn: datagram_received: len=1332 id=0 0.129392607s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 1 } id=0 0.129409929s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Ping id=0 0.129469420s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Padding id=0 0.129540203s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.809ms) processing_duration=256µs 0.131287497s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.131317483s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.131349593s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.131387554s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 0.131410206s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 1196, is_fin: false } id=0 0.131507959s s2n_quic:client:conn: rx_stream_progress: bytes=1196 id=0 0.131570736s s2n_quic:client: platform_event_loop_sleep: timeout=Some(22.778ms) processing_duration=283µs 0.132330826s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.132366723s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.132398523s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.132429921s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 0.132473753s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 0, offset: 1196, len: 1194, is_fin: false } id=0 0.132522163s s2n_quic:client:conn: rx_stream_progress: bytes=1194 id=0 0.132565194s s2n_quic:client: platform_event_loop_sleep: timeout=Some(21.782ms) processing_duration=237µs 0.134550653s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.134585047s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.134618249s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.134650038s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 0.134669134s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 0, offset: 2390, len: 1194, is_fin: false } id=0 0.134723125s s2n_quic:client:conn: rx_stream_progress: bytes=1194 id=0 0.134767939s s2n_quic:client: platform_event_loop_sleep: timeout=Some(19.579ms) processing_duration=220µs 0.135577982s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.135611986s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.135644456s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.135675294s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 0.135694219s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 0, offset: 3584, len: 1194, is_fin: false } id=0 0.135747048s s2n_quic:client:conn: rx_stream_progress: bytes=1194 id=0 0.135792152s s2n_quic:client: platform_event_loop_sleep: timeout=Some(18.555ms) processing_duration=216µs 0.137844637s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.137878059s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.137910500s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.137941818s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 0.137961645s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 0, offset: 4778, len: 342, is_fin: true } id=0 0.138000357s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 848, is_fin: false } id=0 0.138043568s s2n_quic:client:conn: rx_stream_progress: bytes=1190 id=0 0.138087180s s2n_quic:client: platform_event_loop_sleep: timeout=Some(16.26ms) processing_duration=245µs 0.138868149s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.138901341s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.138933932s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.138965540s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 7 } id=0 0.138984686s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 848, len: 1194, is_fin: false } id=0 0.139031294s s2n_quic:client:conn: rx_stream_progress: bytes=1194 id=0 0.139074214s s2n_quic:client: platform_event_loop_sleep: timeout=Some(15.273ms) processing_duration=208µs 0.141118523s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.141152065s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.141184436s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.141215654s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 8 } id=0 0.141240781s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 8 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 2042, len: 1194, is_fin: false } id=0 0.141289642s s2n_quic:client:conn: rx_stream_progress: bytes=1194 id=0 0.141334176s s2n_quic:client: platform_event_loop_sleep: timeout=Some(13.013ms) processing_duration=218µs 0.142052487s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.142092602s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.142131425s s2n_quic:client:conn: datagram_received: len=1092 id=0 0.142168564s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 9 } id=0 0.142191437s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 9 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 3236, len: 1054, is_fin: false } id=0 0.142254164s s2n_quic:client:conn: rx_stream_progress: bytes=1054 id=0 0.142307915s s2n_quic:client: platform_event_loop_sleep: timeout=Some(12.04ms) processing_duration=258µs 0.148396659s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.148431374s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.148491686s s2n_quic:client:conn: datagram_received: len=43 id=0 0.148523836s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 10 } id=0 0.148546068s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 0.148575052s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } ack_range=0..=0 id=0 0.148658017s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.75ms, delivered_bytes: 1231, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1160, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 36474 } id=0 0.148693133s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=33.75ms smoothed_rtt=44.200875ms latest_rtt=53.051ms rtt_variance=18.01325ms max_ack_delay=20ms pto_count=0 congestion_window=14783 bytes_in_flight=1599 congestion_limited=false id=0 0.148754668s s2n_quic:client: platform_event_loop_sleep: timeout=Some(5.593ms) processing_duration=360µs 0.154888396s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.154950302s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=33.75ms smoothed_rtt=44.200875ms latest_rtt=53.051ms rtt_variance=18.01325ms max_ack_delay=20ms pto_count=0 congestion_window=14783 bytes_in_flight=1599 congestion_limited=false id=0 0.155045310s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 9, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 10, ack_range_count: 1 } id=0 0.155075326s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 3 } path_id=0 ack_range=0..=10 id=0 0.155103198s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Padding id=0 0.155140317s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=47 id=0 0.155158471s s2n_quic:client:conn: datagram_sent: len=47 gso_offset=0 id=0 0.155196362s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=33.75ms smoothed_rtt=44.200875ms latest_rtt=53.051ms rtt_variance=18.01325ms max_ack_delay=20ms pto_count=0 congestion_window=14783 bytes_in_flight=1599 congestion_limited=false id=0 0.155262014s s2n_quic:client: platform_event_loop_sleep: timeout=Some(109.788ms) processing_duration=374µs 0.160933209s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.160973003s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.160988783s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.161026503s s2n_quic:client:conn: datagram_received: len=42 id=0 0.161063533s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 11 } id=0 0.161089080s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 2, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 1, ack_range_count: 1 } id=0 0.161116672s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } ack_range=0..=1 id=0 0.161143933s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 0.161194277s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 34.443ms, delivered_bytes: 1523, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 2392, bytes_in_flight: 1523, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 44217 } id=0 0.161228561s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=42.702638ms latest_rtt=32.215ms rtt_variance=16.506404ms max_ack_delay=20ms pto_count=0 congestion_window=18874 bytes_in_flight=147 congestion_limited=false id=0 0.161327586s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Ping id=0 0.161397456s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Padding id=0 0.161430328s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=5202 id=0 0.161476965s s2n_quic:client:conn: datagram_sent: len=5202 gso_offset=0 id=0 0.161512672s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x059b5b88aa454415d132e4988773d3a0, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=42.702638ms latest_rtt=32.215ms rtt_variance=16.506404ms max_ack_delay=20ms pto_count=0 congestion_window=18874 bytes_in_flight=5349 congestion_limited=false id=0 0.161565210s s2n_quic:client: platform_event_loop_sleep: timeout=Some(128.47ms) processing_duration=634µs 0.162142288s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.162174398s s2n_quic:client: platform_tx_error: errno=90 0.162185849s s2n_quic:client: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 0.162197902s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.162228930s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.162260228s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 12 } id=0 0.162275216s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x059b5b88aa454415d132e4988773d3a0 current=0x637aacb39f2b7ef1ecf9fff242010944 id=0 0.162295424s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 0 } id=0 0.162329507s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=RetireConnectionId id=0 0.162356107s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 4290, len: 1162, is_fin: false } id=0 0.162401702s s2n_quic:client:conn: rx_stream_progress: bytes=1162 id=0 0.162477013s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.741ms) processing_duration=336µs 0.163167453s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.163197900s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.163229940s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.163261218s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 13 } id=0 0.163280374s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 13 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 5452, len: 1194, is_fin: false } id=0 0.163326881s s2n_quic:client:conn: rx_stream_progress: bytes=1194 id=0 0.163377035s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.841ms) processing_duration=211µs 0.181551360s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.181596394s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.181638603s s2n_quic:client:conn: datagram_received: len=43 id=0 0.181678066s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 14 } id=0 0.181705598s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 14 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 3, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 2, ack_range_count: 1 } id=0 0.181735604s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 14 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } ack_range=0..=2 id=0 0.181802940s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 34.443ms, delivered_bytes: 1670, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 2392, bytes_in_flight: 1523, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 48485 } id=0 0.181840039s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=5202 congestion_limited=false id=0 0.181916381s s2n_quic:client: platform_event_loop_sleep: timeout=Some(5.302ms) processing_duration=367µs 0.186934777s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.186966666s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.187000329s s2n_quic:client:conn: datagram_received: len=1372 id=0 0.187034643s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 15 } id=0 0.187053178s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Ping id=0 0.187073335s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=MaxStreams { stream_type: Bidirectional, value: 17 } id=0 0.187096398s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 6646, len: 1331, is_fin: false } id=0 0.187143737s s2n_quic:client:conn: rx_stream_progress: bytes=1331 id=0 0.187211894s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 10, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 15, ack_range_count: 1 } id=0 0.187243183s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 5 } path_id=0 ack_range=1..=15 id=0 0.187267338s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Padding id=0 0.187298576s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=47 id=0 0.187313404s s2n_quic:client:conn: datagram_sent: len=47 gso_offset=0 id=0 0.187345564s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=5202 congestion_limited=false id=0 0.187396259s s2n_quic:client: platform_event_loop_sleep: timeout=Some(94.648ms) processing_duration=463µs 0.188035203s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.188069476s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.188082791s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.188114440s s2n_quic:client:conn: datagram_received: len=1332 id=0 0.188147362s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 16 } id=0 0.188166698s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 16 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 7977, len: 1294, is_fin: false } id=0 0.188220218s s2n_quic:client:conn: rx_stream_progress: bytes=1294 id=0 0.188275141s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.828ms) processing_duration=241µs 0.189127924s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.189161737s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.189194959s s2n_quic:client:conn: datagram_received: len=1318 id=0 0.189226919s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 17 } id=0 0.189246856s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 17 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Stream { id: 4, offset: 9271, len: 969, is_fin: true } id=0 0.189286610s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 17 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Crypto { offset: 0, len: 305 } id=0 0.189458752s s2n_quic:client:conn: rx_stream_progress: bytes=969 id=0 0.189519155s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.583ms) processing_duration=393µs 0.189652624s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.189681698s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.189713688s s2n_quic:client:conn: datagram_received: len=79 id=0 0.189750757s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 18 } id=0 0.189770665s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=NewToken id=0 0.189827741s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.275ms) processing_duration=176µs 0.189975557s s2n_quic:client:conn: connection_closed: error=Closed { initiator: Local, source: Location { file: "/app/quic/s2n-quic-transport/src/connection/connection_impl.rs", line: 567, col: 61 } } id=0 0.190054976s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=ConnectionClose id=0 0.190088258s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=Padding id=0 0.190126659s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=47 id=0 0.190185179s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.190223761s s2n_quic:client:conn: datagram_sent: len=47 gso_offset=0 id=0 0.190255139s s2n_quic:client: platform_event_loop_sleep: timeout=Some(22.847ms) processing_duration=71µs 0.213554196s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.213603929s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.213659873s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=5202 congestion_limited=false id=0 0.213725496s s2n_quic:client: platform_event_loop_sleep: timeout=Some(68.32ms) processing_duration=175µs 0.219319386s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.219356185s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.219405797s s2n_quic:client:conn: datagram_received: len=1422 id=0 0.219486077s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 19 } id=0 0.219519750s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Ping id=0 0.219582507s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Padding id=0 0.219659562s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.725ms) processing_duration=341µs 0.220816893s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.220845838s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.220878258s s2n_quic:client:conn: datagram_received: len=48 id=0 0.220909296s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 20 } id=0 0.220940384s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 6, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 6, ack_range_count: 2 } id=0 0.220966433s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } ack_range=5..=6 id=0 0.221006768s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } ack_range=0..=3 id=0 0.221051422s s2n_quic:client:conn: packet_lost: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } bytes_lost=5202 is_mtu_probe=true id=0 0.221080897s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=0 congestion_limited=false id=0 0.221107376s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=ConnectionClose id=0 0.221127734s s2n_quic:client:conn: connection_close_frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: Some(28), reason: None } id=0 0.221167078s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.216ms) processing_duration=352µs 0.245290484s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.245340097s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=0 congestion_limited=false id=0 0.245388487s s2n_quic:client: platform_event_loop_sleep: timeout=Some(26.821ms) processing_duration=100µs 0.272640387s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.272695270s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=0 congestion_limited=false id=0 0.272756755s s2n_quic:client:conn: datagram_sent: len=47 gso_offset=0 id=0 0.272797832s s2n_quic:client: platform_event_loop_sleep: timeout=Some(17.527ms) processing_duration=159µs 0.290992288s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.291028175s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.291072128s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=0 congestion_limited=false id=0 0.291123594s s2n_quic:client: platform_event_loop_sleep: timeout=Some(261.046ms) processing_duration=134µs 0.552688985s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.552824739s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:38815, local_cid: 0x637aacb39f2b7ef1ecf9fff242010944, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x5711604123a3c979928d, id: 0, is_active: true } min_rtt=32.215ms smoothed_rtt=43.648803ms latest_rtt=52.826ms rtt_variance=14.272143ms max_ack_delay=20ms pto_count=0 congestion_window=19021 bytes_in_flight=0 congestion_limited=false id=0 0.553006568s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=332µs