0.077092643s s2n_quic:client: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.077208150s s2n_quic:client: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.077224169s s2n_quic:client: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.077233637s s2n_quic:client: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.077349955s s2n_quic:client: platform_feature_configured: configuration=Gro { enabled: true } 0.077367548s s2n_quic:client: platform_feature_configured: configuration=Ecn { enabled: true } 0.078671546s s2n_quic:client: platform_event_loop_started: local_address=[::]:52190 0.078753730s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.078786030s s2n_quic:client: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.078827548s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=74µs 0.079588190s s2n_quic:client:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.079669352s s2n_quic:client:conn: connection_started: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x4eac6824d3ccc3d9, id: 0, is_active: true } id=0 0.079694369s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 0.079846634s s2n_quic:client:conn: server_name_information: chosen_server_name="server6" id=0 0.079937424s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.080047830s 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.080080101s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.080125506s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=1232 id=0 0.080143810s s2n_quic:client:conn: datagram_sent: len=1232 gso_offset=0 id=0 0.080182352s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x4eac6824d3ccc3d9, 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.080243226s s2n_quic:client: platform_event_loop_sleep: timeout=Some(998.718ms) processing_duration=306µs 0.124956736s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.125008423s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.125025454s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.125104843s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.125157682s s2n_quic:client:conn: packet_received: packet_header=Initial { number: 0, version: 1 } id=0 0.125195452s 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]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x4eac6824d3ccc3d9, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.125233453s 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]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x4eac6824d3ccc3d9, id: 0, is_active: true } ack_range=0..=0 id=0 0.125270422s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1232 cause=InitialMtuPacketAcknowledged search_complete=false id=0 0.125308313s s2n_quic:client:conn: pacing_rate_updated: path_id=0 bytes_per_second=749166 burst_size=12320 pacing_gain=2.77 id=0 0.125346194s s2n_quic:client:conn: ecn_state_changed: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x4eac6824d3ccc3d9, id: 0, is_active: true } state=Failed id=0 0.125370820s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 45.097ms, 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: 27318 } id=0 0.125400746s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x4eac6824d3ccc3d9, id: 0, is_active: true } min_rtt=45.097ms smoothed_rtt=45.097ms latest_rtt=45.097ms rtt_variance=22.5485ms max_ack_delay=0ns pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 0.125433077s 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]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x4eac6824d3ccc3d9, id: 0, is_active: true } frame=Crypto { offset: 0, len: 123 } id=0 0.125512064s s2n_quic:client:conn: tls_server_hello: payload=[[3, 3, 11, 187, 15, 232, 219, 186, 17, 185, 250, 172, 40, 20, 89, 223, 122, 195, 130, 135, 25, 14, 2, 216, 106, 201, 21, 162, 14, 90, 245, 21, 62, 207, 0, 19, 2, 0, 0, 79, 0, 43, 0, 2, 3, 4, 0, 51, 0, 69, 0, 23, 0, 65, 4, 151, 167, 244, 174, 73, 156, 174, 196, 26, 38, 218, 247, 80, 242, 246, 158, 75, 195, 34, 225, 185, 75, 7, 77, 9, 28, 14, 2, 3, 211, 222, 109, 197, 144, 147, 57, 134, 99, 84, 55, 166, 60, 173, 35, 29, 86, 126, 120, 22, 3, 65, 155, 226, 35, 44, 238, 33, 148, 94, 216, 44, 22, 252, 92]] id=0 0.125797338s s2n_quic:client:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_256_GCM_SHA384 id=0 0.125887356s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 1, version: 1 } id=0 0.125915759s 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]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } frame=Crypto { offset: 0, len: 734 } id=0 0.126404603s s2n_quic:client:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 0.126434058s s2n_quic:client:conn: key_exchange_group: chosen_group_name="secp256r1" contains_kem=false id=0 0.126497257s s2n_quic:client:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: Some(0x4eac6824d3ccc3d9), initial_source_connection_id: Some(0xb388fd678375985a), retry_source_connection_id: None, stateless_reset_token: Some([253, 227, 141, 203, 41, 61, 244, 204, 127, 120, 189, 31, 38, 204, 84, 61]), preferred_address: None, migration_support: true, max_idle_timeout: 60s, ack_delay_exponent: 3, max_ack_delay: 25ms, 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: 128, initial_max_streams_uni: 128, max_datagram_frame_size: 65536, dc_supported_versions: [] } id=0 0.126591733s s2n_quic:client:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_256_GCM_SHA384 id=0 0.126692722s s2n_quic:client:conn: handshake_status_updated: status=Complete id=0 0.126712950s s2n_quic:client:conn: tls_exporter_ready: session=TlsSession { .. } id=0 0.126754508s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 0.126777701s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } frame=Crypto { offset: 0, len: 89 } id=0 0.126811624s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } frame=Padding id=0 0.126992843s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.127025294s s2n_quic:client:conn: ack_range_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 ack_range=0..=0 id=0 0.127042587s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Padding id=0 0.127068044s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 1, version: 1 } packet_len=70 id=0 0.127097840s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 0.127112587s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 ack_range=1..=1 id=0 0.127131763s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 52 } id=0 0.127152542s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.127180755s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1162 id=0 0.127197907s s2n_quic:client:conn: key_space_discarded: space=Initial id=0 0.127210140s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } min_rtt=45.097ms smoothed_rtt=45.097ms latest_rtt=45.097ms rtt_variance=22.5485ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1162 congestion_limited=false id=0 0.127274500s s2n_quic:client:conn: datagram_sent: len=1232 gso_offset=0 id=0 0.127310918s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } min_rtt=45.097ms smoothed_rtt=45.097ms latest_rtt=45.097ms rtt_variance=22.5485ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1162 congestion_limited=false id=0 0.127365190s s2n_quic:client: platform_event_loop_sleep: timeout=Some(22.694ms) processing_duration=2.411ms 0.127808449s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.127859183s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.127927511s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 2, ack_range_count: 1 } id=0 0.127966364s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 0 } path_id=0 ack_range=2..=2 id=0 0.128003644s 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.128039992s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 0, offset: 0, len: 28, is_fin: true } id=0 0.128077201s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 4, offset: 0, len: 32, is_fin: true } id=0 0.128120122s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=101 id=0 0.128136502s s2n_quic:client:conn: datagram_sent: len=101 gso_offset=0 id=0 0.128171718s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } min_rtt=45.097ms smoothed_rtt=45.097ms latest_rtt=45.097ms rtt_variance=22.5485ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1263 congestion_limited=false id=0 0.128203628s s2n_quic:client:conn: tx_stream_progress: bytes=60 id=0 0.128237992s s2n_quic:client: platform_event_loop_sleep: timeout=Some(134.006ms) processing_duration=432µs 0.159828779s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.159873302s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.159888130s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.159932392s s2n_quic:client:conn: datagram_received: len=92 id=0 0.159972558s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 0.159991854s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } frame=HandshakeDone id=0 0.160017792s s2n_quic:client:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 0.160028943s s2n_quic:client:conn: handshake_status_updated: status=Confirmed id=0 0.160051215s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0xb388fd678375985a, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 0.160090218s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0xb388fd678375985a current=0x9ef440d17961d75d id=0 0.160110235s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 0.160148096s s2n_quic:client:conn: key_space_discarded: space=Handshake id=0 0.160163725s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=45.097ms smoothed_rtt=45.097ms latest_rtt=45.097ms rtt_variance=22.5485ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1263 congestion_limited=false id=0 0.160307975s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 0.160335827s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 1 } path_id=0 ack_range=2..=3 id=0 0.160356195s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 1, retire_prior_to: 1 } id=0 0.160370502s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 2, retire_prior_to: 1 } id=0 0.160383145s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 0.160399155s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=RetireConnectionId id=0 0.160441294s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=141 id=0 0.160500475s s2n_quic:client:conn: datagram_sent: len=141 gso_offset=0 id=0 0.160540650s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=45.097ms smoothed_rtt=45.097ms latest_rtt=45.097ms rtt_variance=22.5485ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=242 congestion_limited=false id=0 0.160593829s s2n_quic:client: platform_event_loop_sleep: timeout=Some(159.974ms) processing_duration=769µs 0.165042409s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.165075711s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.165089327s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.165121917s s2n_quic:client:conn: datagram_received: len=41 id=0 0.165152114s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 0.165173614s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.165202007s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } ack_range=0..=0 id=0 0.165277929s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.153ms, delivered_bytes: 101, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1263, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 2647 } id=0 0.165311783s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=37.215ms smoothed_rtt=44.11175ms latest_rtt=37.215ms rtt_variance=18.881875ms max_ack_delay=25ms pto_count=0 congestion_window=13653 bytes_in_flight=141 congestion_limited=false id=0 0.165390560s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ping id=0 0.165420957s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Padding id=0 0.165476160s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1452 id=0 0.165497981s s2n_quic:client:conn: datagram_sent: len=1452 gso_offset=0 id=0 0.165530121s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=37.215ms smoothed_rtt=44.11175ms latest_rtt=37.215ms rtt_variance=18.881875ms max_ack_delay=25ms pto_count=0 congestion_window=13653 bytes_in_flight=1593 congestion_limited=false id=0 0.165582990s s2n_quic:client: platform_event_loop_sleep: timeout=Some(144.427ms) processing_duration=542µs 0.170583191s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.170622604s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.170638985s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.170676876s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.170713585s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 0.170737359s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 1161, is_fin: false } id=0 0.170829231s s2n_quic:client:conn: rx_stream_progress: bytes=1161 id=0 0.170921373s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.742ms) processing_duration=338µs 0.171575036s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.171615040s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.171653893s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.171689971s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 0.171713415s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 0, offset: 1161, len: 1159, is_fin: false } id=0 0.171757377s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.171798003s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.863ms) processing_duration=225µs 0.172555049s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.172587149s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.172619309s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.172649145s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 7 } id=0 0.172667719s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 0, offset: 2320, len: 1159, is_fin: false } id=0 0.172717282s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.172759000s s2n_quic:client: platform_event_loop_sleep: timeout=Some(22.902ms) processing_duration=206µs 0.173555048s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.173586958s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.173619219s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.173649255s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 8 } id=0 0.173667679s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 8 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 1161, is_fin: false } id=0 0.173712783s s2n_quic:client:conn: rx_stream_progress: bytes=1161 id=0 0.173754441s s2n_quic:client: platform_event_loop_sleep: timeout=Some(21.907ms) processing_duration=201µs 0.174554648s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.174586427s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.174618076s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.174648073s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 9 } id=0 0.174666698s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 9 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 0, offset: 3479, len: 1159, is_fin: false } id=0 0.174715278s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.174756716s s2n_quic:client: platform_event_loop_sleep: timeout=Some(20.904ms) processing_duration=204µs 0.175553927s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.175585496s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.175617255s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.175647281s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 10 } id=0 0.175666067s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 1161, len: 1159, is_fin: false } id=0 0.175708646s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.175749202s s2n_quic:client: platform_event_loop_sleep: timeout=Some(19.912ms) processing_duration=197µs 0.178591367s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.178625311s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.178658252s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.178688679s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 11 } id=0 0.178707725s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 0, offset: 4638, len: 482, is_fin: true } id=0 0.178749814s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 2320, len: 671, is_fin: false } id=0 0.178788736s s2n_quic:client:conn: rx_stream_progress: bytes=1153 id=0 0.178829322s s2n_quic:client: platform_event_loop_sleep: timeout=Some(16.832ms) processing_duration=240µs 0.179590446s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.179623147s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.179655718s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.179686024s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 12 } id=0 0.179705020s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 2991, len: 1159, is_fin: false } id=0 0.179753971s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.179801049s s2n_quic:client: platform_event_loop_sleep: timeout=Some(15.86ms) processing_duration=213µs 0.182840921s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.182874354s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.182907205s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.182937762s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 13 } id=0 0.182956798s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 13 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 4150, len: 1159, is_fin: false } id=0 0.183000159s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.183057226s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 13, ack_range_count: 1 } id=0 0.183078055s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 3 } path_id=0 ack_range=3..=13 id=0 0.183100366s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Padding id=0 0.183128379s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=45 id=0 0.183143267s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.183171780s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=37.215ms smoothed_rtt=44.11175ms latest_rtt=37.215ms rtt_variance=18.881875ms max_ack_delay=25ms pto_count=0 congestion_window=13653 bytes_in_flight=1593 congestion_limited=false id=0 0.183234447s s2n_quic:client: platform_event_loop_sleep: timeout=Some(126.777ms) processing_duration=394µs 0.183832766s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.183865467s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.183878522s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.183909269s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.183939426s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 14 } id=0 0.183958221s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 14 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 5309, len: 1159, is_fin: false } id=0 0.184001532s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.184048049s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.849ms) processing_duration=217µs 0.187053650s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.187085990s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.187118060s s2n_quic:client:conn: datagram_received: len=1108 id=0 0.187147806s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 15 } id=0 0.187166651s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x05f0f6ef687f57d99862f6a9fc35007c, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 6468, len: 1067, is_fin: false } id=0 0.187210072s s2n_quic:client:conn: rx_stream_progress: bytes=1067 id=0 0.187250398s s2n_quic:client: platform_event_loop_sleep: timeout=Some(21.647ms) processing_duration=198µs 0.191799946s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.191831715s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.191863645s s2n_quic:client:conn: datagram_received: len=184 id=0 0.191893361s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 16 } id=0 0.191907868s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x05f0f6ef687f57d99862f6a9fc35007c current=0x2f3293172fc6ab64ed73def15c092c11 id=0 0.191927274s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 16 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 0 } id=0 0.191959945s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 16 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=RetireConnectionId id=0 0.191983068s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 16 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=RetireConnectionId id=0 0.192002966s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 16 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 7535, len: 111, is_fin: false } id=0 0.192050615s s2n_quic:client:conn: rx_stream_progress: bytes=111 id=0 0.192131566s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 16, ack_range_count: 1 } id=0 0.192156503s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 4 } path_id=0 ack_range=3..=16 id=0 0.192175117s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=NewConnectionId { sequence_number: 4, retire_prior_to: 1 } id=0 0.192210524s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=67 id=0 0.192227155s s2n_quic:client:conn: datagram_sent: len=67 gso_offset=0 id=0 0.192256870s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=37.215ms smoothed_rtt=44.11175ms latest_rtt=37.215ms rtt_variance=18.881875ms max_ack_delay=25ms pto_count=0 congestion_window=13653 bytes_in_flight=1660 congestion_limited=false id=0 0.192306523s s2n_quic:client: platform_event_loop_sleep: timeout=Some(131.88ms) processing_duration=508µs 0.192859337s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.192891176s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.192904341s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.192934888s s2n_quic:client:conn: datagram_received: len=41 id=0 0.192964413s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 17 } id=0 0.192984682s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 17 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 0.193006522s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 17 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } ack_range=0..=1 id=0 0.193060834s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.153ms, delivered_bytes: 242, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1263, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 6342 } id=0 0.193089928s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.645ms smoothed_rtt=42.678401ms latest_rtt=32.645ms rtt_variance=17.028091ms max_ack_delay=25ms pto_count=0 congestion_window=13794 bytes_in_flight=1519 congestion_limited=false id=0 0.193147706s s2n_quic:client: platform_event_loop_sleep: timeout=Some(131.039ms) processing_duration=289µs 0.198642906s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.198695003s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.198762520s s2n_quic:client:conn: datagram_received: len=41 id=0 0.198828844s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 18 } id=0 0.198877435s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 2, ack_range_count: 1 } id=0 0.198926386s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } ack_range=0..=2 id=0 0.198969076s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 0.199035961s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 37.482ms, delivered_bytes: 1593, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1333, bytes_in_flight: 1593, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 42500 } id=0 0.199095252s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.645ms smoothed_rtt=41.49535ms latest_rtt=33.367ms rtt_variance=15.137166ms max_ack_delay=25ms pto_count=0 congestion_window=17709 bytes_in_flight=67 congestion_limited=false id=0 0.199240183s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Ping id=0 0.199335111s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Padding id=0 0.199409309s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=5202 id=0 0.199441590s s2n_quic:client:conn: datagram_sent: len=5202 gso_offset=0 id=0 0.199539393s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.645ms smoothed_rtt=41.49535ms latest_rtt=33.367ms rtt_variance=15.137166ms max_ack_delay=25ms pto_count=0 congestion_window=17709 bytes_in_flight=5269 congestion_limited=false id=0 0.199612359s s2n_quic:client: platform_event_loop_sleep: timeout=Some(124.575ms) processing_duration=971µs 0.215493281s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.215529659s s2n_quic:client: platform_tx_error: errno=90 0.215541772s s2n_quic:client: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 0.215554105s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.215585293s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.215616161s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 19 } id=0 0.215635557s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 7646, len: 1159, is_fin: false } id=0 0.215685170s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.215743789s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.83ms) processing_duration=252µs 0.216473033s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.216504963s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.216536582s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.216566188s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 20 } id=0 0.216585043s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 8805, len: 1159, is_fin: false } id=0 0.216628905s s2n_quic:client:conn: rx_stream_progress: bytes=1159 id=0 0.216669601s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.903ms) processing_duration=198µs 0.216780859s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.216806958s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.216837755s s2n_quic:client:conn: datagram_received: len=317 id=0 0.216867351s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 21 } id=0 0.216886556s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 21 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Stream { id: 4, offset: 9964, len: 276, is_fin: true } id=0 0.216928856s s2n_quic:client:conn: rx_stream_progress: bytes=276 id=0 0.216969301s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.604ms) processing_duration=189µs 0.217142666s s2n_quic:client:conn: connection_closed: error=Closed { initiator: Local, source: Location { file: "/app/quic/s2n-quic-transport/src/connection/connection_impl.rs", line: 575, column: 61 } } id=0 0.217209090s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=ConnectionClose id=0 0.217244345s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=Padding id=0 0.217282016s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=45 id=0 0.217337971s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.217385720s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.217417560s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.155ms) processing_duration=81µs 0.224235961s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.224274122s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.224290052s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.224328614s s2n_quic:client:conn: datagram_received: len=41 id=0 0.224366335s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 22 } id=0 0.224391321s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 22 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 4, ack_range_count: 1 } id=0 0.224425756s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 22 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } ack_range=1..=4 id=0 0.224509833s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 37.482ms, delivered_bytes: 1660, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1333, bytes_in_flight: 1593, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 44287 } id=0 0.224549157s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.203ms smoothed_rtt=40.333801ms latest_rtt=32.203ms rtt_variance=13.67596ms max_ack_delay=25ms pto_count=0 congestion_window=17776 bytes_in_flight=5202 congestion_limited=false id=0 0.224615000s s2n_quic:client: platform_event_loop_sleep: timeout=Some(15.959ms) processing_duration=380µs 0.240752659s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.240835314s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.203ms smoothed_rtt=40.333801ms latest_rtt=32.203ms rtt_variance=13.67596ms max_ack_delay=25ms pto_count=0 congestion_window=17776 bytes_in_flight=5202 congestion_limited=false id=0 0.240899083s s2n_quic:client: platform_event_loop_sleep: timeout=Some(16.782ms) processing_duration=147µs 0.258039527s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.258097084s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.203ms smoothed_rtt=40.333801ms latest_rtt=32.203ms rtt_variance=13.67596ms max_ack_delay=25ms pto_count=0 congestion_window=17776 bytes_in_flight=5202 congestion_limited=false id=0 0.258153039s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.258195929s s2n_quic:client: platform_event_loop_sleep: timeout=Some(61.051ms) processing_duration=157µs 0.320509357s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.320582494s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.320657634s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.203ms smoothed_rtt=40.333801ms latest_rtt=32.203ms rtt_variance=13.67596ms max_ack_delay=25ms pto_count=1 congestion_window=17776 bytes_in_flight=5202 congestion_limited=false id=0 0.320731252s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.456ms) processing_duration=231µs 0.325004413s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.325084963s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.203ms smoothed_rtt=40.333801ms latest_rtt=32.203ms rtt_variance=13.67596ms max_ack_delay=25ms pto_count=1 congestion_window=17776 bytes_in_flight=5202 congestion_limited=false id=0 0.325155485s s2n_quic:client: platform_event_loop_sleep: timeout=Some(114.124ms) processing_duration=153µs 0.440529569s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.440651247s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.203ms smoothed_rtt=40.333801ms latest_rtt=32.203ms rtt_variance=13.67596ms max_ack_delay=25ms pto_count=2 congestion_window=17776 bytes_in_flight=5202 congestion_limited=false id=0 0.440729383s s2n_quic:client: platform_event_loop_sleep: timeout=Some(157.537ms) processing_duration=209µs 0.599123247s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.599240676s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:52190, local_cid: 0x2f3293172fc6ab64ed73def15c092c11, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x9ef440d17961d75d, id: 0, is_active: true } min_rtt=32.203ms smoothed_rtt=40.333801ms latest_rtt=32.203ms rtt_variance=13.67596ms max_ack_delay=25ms pto_count=2 congestion_window=17776 bytes_in_flight=5202 congestion_limited=false id=0 0.599400786s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=289µs