0.045941705s s2n_quic:client: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.046032825s s2n_quic:client: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.046048535s s2n_quic:client: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.046058053s s2n_quic:client: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.046153852s s2n_quic:client: platform_feature_configured: configuration=Gro { enabled: true } 0.046174470s s2n_quic:client: platform_feature_configured: configuration=Ecn { enabled: true } 0.047412897s s2n_quic:client: platform_event_loop_started: local_address=[::]:43797 0.047495632s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.047519437s s2n_quic:client: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.047554893s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=59µs 0.048190993s s2n_quic:client:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.048262658s s2n_quic:client:conn: connection_started: path=Path { local_addr: 0.0.0.0:0, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0x74fdcd35477d76fa, id: 0, is_active: true } id=0 0.048286883s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1252 cause=NewPath search_complete=false id=0 0.048440160s s2n_quic:client:conn: server_name_information: chosen_server_name="server4" id=0 0.048541209s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.048655373s 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.048721406s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.048769486s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=1252 id=0 0.048788381s s2n_quic:client:conn: datagram_sent: len=1252 gso_offset=0 id=0 0.048826052s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 0.0.0.0:0, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0x74fdcd35477d76fa, 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=12520 bytes_in_flight=1252 congestion_limited=false id=0 0.048889561s s2n_quic:client: platform_event_loop_sleep: timeout=Some(998.677ms) processing_duration=347µs 0.087313405s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.087356165s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.087370883s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.087432679s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.087470900s s2n_quic:client:conn: packet_received: packet_header=Initial { number: 0, version: 1 } id=0 0.087502449s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0x74fdcd35477d76fa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.087539338s s2n_quic:client:conn: ack_range_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0x74fdcd35477d76fa, id: 0, is_active: true } ack_range=0..=0 id=0 0.087571639s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1252 cause=InitialMtuPacketAcknowledged search_complete=false id=0 0.087608979s s2n_quic:client:conn: pacing_rate_updated: path_id=0 bytes_per_second=884271 burst_size=12520 pacing_gain=2.77 id=0 0.087642080s s2n_quic:client:conn: ecn_state_changed: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0x74fdcd35477d76fa, id: 0, is_active: true } state=Failed id=0 0.087663190s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.827ms, delivered_bytes: 1252, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 1252, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 32245 } id=0 0.087716560s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0x74fdcd35477d76fa, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13772 bytes_in_flight=0 congestion_limited=false id=0 0.087747187s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0x74fdcd35477d76fa, id: 0, is_active: true } frame=Crypto { offset: 0, len: 123 } id=0 0.087790759s s2n_quic:client:conn: tls_server_hello: payload=[[3, 3, 216, 227, 108, 111, 94, 112, 75, 200, 79, 91, 220, 191, 68, 252, 192, 207, 211, 97, 99, 188, 132, 84, 28, 167, 222, 34, 222, 254, 135, 136, 193, 181, 0, 19, 1, 0, 0, 79, 0, 43, 0, 2, 3, 4, 0, 51, 0, 69, 0, 23, 0, 65, 4, 85, 151, 20, 161, 130, 242, 173, 139, 239, 11, 165, 232, 229, 88, 176, 44, 119, 114, 186, 107, 200, 77, 87, 116, 186, 22, 133, 121, 243, 107, 234, 137, 56, 8, 180, 74, 83, 40, 173, 84, 250, 117, 12, 213, 20, 28, 75, 173, 147, 139, 249, 200, 171, 190, 246, 58, 4, 27, 47, 13, 82, 173, 59, 223]] id=0 0.088038272s s2n_quic:client:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.088123321s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 0, version: 1 } id=0 0.088153738s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 0, len: 963 } id=0 0.088288430s 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.088322033s s2n_quic:client:conn: ack_range_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 ack_range=0..=0 id=0 0.088340247s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Padding id=0 0.088366877s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 1, version: 1 } packet_len=70 id=0 0.088396422s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.088412041s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 0.088433461s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.088459500s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1182 id=0 0.088485779s s2n_quic:client:conn: key_space_discarded: space=Initial id=0 0.088499956s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13772 bytes_in_flight=0 congestion_limited=false id=0 0.088549909s s2n_quic:client:conn: datagram_sent: len=1252 gso_offset=0 id=0 0.088580867s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13772 bytes_in_flight=0 congestion_limited=false id=0 0.088634397s s2n_quic:client: platform_event_loop_sleep: timeout=Some(116.101ms) processing_duration=1.323ms 0.088767777s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.088799637s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.088812851s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.088846795s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.088877743s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 1, version: 1 } id=0 0.088896618s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 1, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 963, len: 1145 } id=0 0.088985665s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 0.089013847s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 ack_range=0..=1 id=0 0.089031340s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 frame=Padding id=0 0.089057159s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 1, version: 1 } packet_len=69 id=0 0.089071996s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.089099498s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13772 bytes_in_flight=0 congestion_limited=false id=0 0.089143109s s2n_quic:client: platform_event_loop_sleep: timeout=Some(115.592ms) processing_duration=377µs 0.089248857s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.089275998s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.089288621s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.089322625s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.089353112s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 2, version: 1 } id=0 0.089377828s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 2108, len: 1145 } id=0 0.089468238s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 2, ack_range_count: 1 } id=0 0.089496130s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 ack_range=0..=2 id=0 0.089513352s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 frame=Padding id=0 0.089539100s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 2, version: 1 } packet_len=69 id=0 0.089553818s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.089580648s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13772 bytes_in_flight=0 congestion_limited=false id=0 0.089634228s s2n_quic:client: platform_event_loop_sleep: timeout=Some(115.108ms) processing_duration=379µs 0.089769151s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.089800459s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.089813654s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.089857326s s2n_quic:client:conn: datagram_received: len=156 id=0 0.089887272s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 3, version: 1 } id=0 0.089905907s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 3, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 3253, len: 101 } id=0 0.089994252s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 0.090022334s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 ack_range=0..=3 id=0 0.090039246s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 frame=Padding id=0 0.090064934s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 3, version: 1 } packet_len=69 id=0 0.090079872s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.090106442s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13772 bytes_in_flight=0 congestion_limited=false id=0 0.090150634s s2n_quic:client: platform_event_loop_sleep: timeout=Some(114.584ms) processing_duration=383µs 0.204547146s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.204595657s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.204664145s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=1 congestion_window=13772 bytes_in_flight=0 congestion_limited=false id=0 0.204772788s s2n_quic:client:conn: packet_skipped: number=4 space=Handshake reason=PtoProbe id=0 0.204818644s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 5, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 0.204842008s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 5, version: 1 } path_id=0 ack_range=0..=3 id=0 0.204863087s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 5, version: 1 } path_id=0 frame=Ping id=0 0.204881913s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 5, version: 1 } path_id=0 frame=Padding id=0 0.204918701s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 5, version: 1 } packet_len=69 id=0 0.204939009s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.204969346s s2n_quic:client:conn: packet_skipped: number=6 space=Handshake reason=PtoProbe id=0 0.205000995s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 7, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 0.205020882s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 7, version: 1 } path_id=0 ack_range=0..=3 id=0 0.205039928s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 7, version: 1 } path_id=0 frame=Ping id=0 0.205058002s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 7, version: 1 } path_id=0 frame=Padding id=0 0.205088459s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 7, version: 1 } packet_len=69 id=0 0.205107505s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.205143983s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=1 congestion_window=13772 bytes_in_flight=138 congestion_limited=false id=0 0.205217470s s2n_quic:client: platform_event_loop_sleep: timeout=Some(232.496ms) processing_duration=673µs 0.437720873s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.437758614s s2n_quic:client: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.437801234s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=2 congestion_window=13772 bytes_in_flight=138 congestion_limited=false id=0 0.437852149s s2n_quic:client:conn: packet_skipped: number=8 space=Handshake reason=PtoProbe id=0 0.437885652s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 0.437902984s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 ack_range=0..=3 id=0 0.437926218s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 frame=Ping id=0 0.437941436s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 frame=Padding id=0 0.437976421s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 9, version: 1 } packet_len=69 id=0 0.437992431s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.438015254s s2n_quic:client:conn: packet_skipped: number=10 space=Handshake reason=PtoProbe id=0 0.438040011s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 11, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 0.438065027s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 11, version: 1 } path_id=0 ack_range=0..=3 id=0 0.438079384s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 11, version: 1 } path_id=0 frame=Ping id=0 0.438092849s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 11, version: 1 } path_id=0 frame=Padding id=0 0.438116063s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 11, version: 1 } packet_len=69 id=0 0.438130300s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.438156398s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=38.827ms smoothed_rtt=38.827ms latest_rtt=38.827ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=2 congestion_window=13772 bytes_in_flight=276 congestion_limited=false id=0 0.438211862s s2n_quic:client: platform_event_loop_sleep: timeout=Some(465.548ms) processing_duration=493µs 0.470039648s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.470087568s s2n_quic:client: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.470106503s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.470155145s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.470198495s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 4, version: 1 } id=0 0.470226197s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 4, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 9, ack_range_count: 1 } id=0 0.470267054s s2n_quic:client:conn: ack_range_received: packet_header=Handshake { number: 4, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } ack_range=9..=9 id=0 0.470327086s s2n_quic:client:conn: packet_lost: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } bytes_lost=0 is_mtu_probe=false id=0 0.470359717s s2n_quic:client:conn: packet_lost: packet_header=Handshake { number: 1, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } bytes_lost=0 is_mtu_probe=false id=0 0.470381729s s2n_quic:client:conn: packet_lost: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } bytes_lost=0 is_mtu_probe=false id=0 0.470410512s s2n_quic:client:conn: packet_lost: packet_header=Handshake { number: 3, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } bytes_lost=0 is_mtu_probe=false id=0 0.470434888s s2n_quic:client:conn: packet_lost: packet_header=Handshake { number: 5, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } bytes_lost=69 is_mtu_probe=false id=0 0.470456488s s2n_quic:client:conn: packet_lost: packet_header=Handshake { number: 7, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } bytes_lost=69 is_mtu_probe=false id=0 0.470480032s s2n_quic:client:conn: congestion: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } source=PacketLoss id=0 0.470512463s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 265.379ms, delivered_bytes: 69, lost_bytes: 138, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1252, bytes_in_flight: 207, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 260 } id=0 0.470545655s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13841 bytes_in_flight=69 congestion_limited=false id=0 0.470581713s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 4, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 3354, len: 1140 } id=0 0.470749226s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 12, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 4, ack_range_count: 1 } id=0 0.470794801s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 12, version: 1 } path_id=0 ack_range=0..=4 id=0 0.470819428s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 12, version: 1 } path_id=0 frame=Padding id=0 0.470850856s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 12, version: 1 } packet_len=69 id=0 0.470865844s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.470893476s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13841 bytes_in_flight=69 congestion_limited=false id=0 0.470946565s s2n_quic:client: platform_event_loop_sleep: timeout=Some(83.377ms) processing_duration=910µs 0.471056220s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.471089262s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.471102647s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.471136621s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.471167308s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 5, version: 1 } id=0 0.471186094s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 5, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 4494, len: 1145 } id=0 0.471274840s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 13, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 5, ack_range_count: 1 } id=0 0.471302662s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 13, version: 1 } path_id=0 ack_range=0..=5 id=0 0.471319413s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 13, version: 1 } path_id=0 frame=Padding id=0 0.471344891s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 13, version: 1 } packet_len=69 id=0 0.471359688s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.471386579s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13841 bytes_in_flight=69 congestion_limited=false id=0 0.471431433s s2n_quic:client: platform_event_loop_sleep: timeout=Some(82.892ms) processing_duration=376µs 0.471948881s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.471984818s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.471999165s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.472034241s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.472066621s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 6, version: 1 } id=0 0.472086358s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 6, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 5639, len: 1145 } id=0 0.472177258s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 14, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 6, ack_range_count: 1 } id=0 0.472205872s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 14, version: 1 } path_id=0 ack_range=0..=6 id=0 0.472223094s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 14, version: 1 } path_id=0 frame=Padding id=0 0.472249133s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 14, version: 1 } packet_len=69 id=0 0.472263790s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.472290661s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13841 bytes_in_flight=69 congestion_limited=false id=0 0.472342397s s2n_quic:client: platform_event_loop_sleep: timeout=Some(81.981ms) processing_duration=395µs 0.472898177s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.472929947s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.472942871s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.472976784s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.473007432s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 7, version: 1 } id=0 0.473026167s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 7, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 6784, len: 1145 } id=0 0.473114772s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 15, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 7, ack_range_count: 1 } id=0 0.473142535s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 15, version: 1 } path_id=0 ack_range=0..=7 id=0 0.473159576s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 15, version: 1 } path_id=0 frame=Padding id=0 0.473185355s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 15, version: 1 } packet_len=69 id=0 0.473199942s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.473226592s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13841 bytes_in_flight=69 congestion_limited=false id=0 0.473270945s s2n_quic:client: platform_event_loop_sleep: timeout=Some(81.052ms) processing_duration=374µs 0.473880515s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.473912044s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.473925059s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.473958752s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.473989289s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 8, version: 1 } id=0 0.474007794s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 8, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 7929, len: 1145 } id=0 0.474104615s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 16, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 8, ack_range_count: 1 } id=0 0.474133038s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 16, version: 1 } path_id=0 ack_range=0..=8 id=0 0.474148907s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 16, version: 1 } path_id=0 frame=Ping id=0 0.474162463s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 16, version: 1 } path_id=0 frame=Padding id=0 0.474189043s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 16, version: 1 } packet_len=69 id=0 0.474210082s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.474239227s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=0ns pto_count=0 congestion_window=13841 bytes_in_flight=138 congestion_limited=false id=0 0.474288549s s2n_quic:client: platform_event_loop_sleep: timeout=Some(116.274ms) processing_duration=409µs 0.474709086s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.474741286s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.474754351s s2n_quic:client: platform_rx: count=2 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.474788364s s2n_quic:client:conn: datagram_received: len=982 id=0 0.474818811s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 9, version: 1 } id=0 0.474837476s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 9, version: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=Crypto { offset: 9074, len: 837 } id=0 0.476572473s s2n_quic:client:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 0.476606907s s2n_quic:client:conn: key_exchange_group: chosen_group_name="secp256r1" contains_kem=false id=0 0.476646531s s2n_quic:client:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: Some(0x74fdcd35477d76fa), initial_source_connection_id: Some(0xc422b816118306a7), retry_source_connection_id: None, stateless_reset_token: None, preferred_address: None, migration_support: false, max_idle_timeout: 0ns, ack_delay_exponent: 3, max_ack_delay: 25ms, max_udp_payload_size: 1472, active_connection_id_limit: 2, initial_max_stream_data_bidi_local: 65536, initial_max_stream_data_bidi_remote: 65536, initial_max_stream_data_uni: 65536, initial_max_streams_bidi: 100, initial_max_streams_uni: 0, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 0.476728084s s2n_quic:client:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.476818623s s2n_quic:client:conn: handshake_status_updated: status=Complete id=0 0.476840003s s2n_quic:client:conn: tls_exporter_ready: session=TlsSession { .. } id=0 0.476881821s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 0 } id=0 0.476906578s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xc422b816118306a7, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 0.476950380s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0xc422b816118306a7 current=0xb773f33dea390db0 id=0 0.476975787s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 0.477083168s s2n_quic:client:conn: datagram_dropped: local_addr=193.167.0.100:43797 remote_addr=[::ffff:193.167.100.100]:443 destination_cid=0xd99f64338258f96c87106b4c47ab0d0e source_cid=Some(0xc422b816118306a7) len=57 reason=InvalidSourceConnectionId id=0 0.477160974s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 17, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 9, ack_range_count: 1 } id=0 0.477184688s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 17, version: 1 } path_id=0 ack_range=0..=9 id=0 0.477204575s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 17, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 36 } id=0 0.477236345s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 17, version: 1 } packet_len=95 id=0 0.477277452s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.477294293s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 0 } path_id=0 ack_range=0..=0 id=0 0.477312718s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=RetireConnectionId id=0 0.477340450s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 0.477370155s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=45 id=0 0.477385123s s2n_quic:client:conn: datagram_sent: len=140 gso_offset=0 id=0 0.477421101s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=25ms pto_count=0 congestion_window=13841 bytes_in_flight=278 congestion_limited=false id=0 0.477475202s s2n_quic:client: platform_event_loop_sleep: timeout=Some(116.143ms) processing_duration=2.768ms 0.477763651s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.477806231s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.477876122s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Stream { id: 0, offset: 0, len: 0, is_fin: false } id=0 0.477917339s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 0.477956592s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=49 id=0 0.477973865s s2n_quic:client:conn: datagram_sent: len=49 gso_offset=0 id=0 0.478009171s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=25ms pto_count=0 congestion_window=13841 bytes_in_flight=327 congestion_limited=false id=0 0.478042483s s2n_quic:client:conn: tx_stream_progress: bytes=17 id=0 0.478075595s s2n_quic:client: platform_event_loop_sleep: timeout=Some(115.542ms) processing_duration=315µs 0.504899190s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.504956808s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.504988387s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.505054842s s2n_quic:client:conn: datagram_dropped: local_addr=193.167.0.100:43797 remote_addr=[::ffff:193.167.100.100]:443 destination_cid=0xd99f64338258f96c87106b4c47ab0d0e source_cid=Some(0xc422b816118306a7) len=57 reason=InvalidSourceConnectionId id=0 0.505143197s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=32.289ms smoothed_rtt=38.827ms latest_rtt=32.289ms rtt_variance=19.4135ms max_ack_delay=25ms pto_count=0 congestion_window=13841 bytes_in_flight=327 congestion_limited=false id=0 0.505196737s s2n_quic:client: platform_event_loop_sleep: timeout=Some(88.421ms) processing_duration=302µs 0.508303250s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.508339377s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.508378621s s2n_quic:client:conn: datagram_received: len=68 id=0 0.508416782s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 1 } id=0 0.508442490s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.508476043s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } ack_range=0..=0 id=0 0.508546645s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 39.295ms, delivered_bytes: 45, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1321, bytes_in_flight: 278, prior_lost_bytes: 138, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 1145 } id=0 0.508584676s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=38.827ms latest_rtt=31.225ms rtt_variance=19.4135ms max_ack_delay=25ms pto_count=0 congestion_window=13886 bytes_in_flight=282 congestion_limited=false id=0 0.508616095s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=HandshakeDone id=0 0.508637585s s2n_quic:client:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 0.508650409s s2n_quic:client:conn: handshake_status_updated: status=Confirmed id=0 0.508701495s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 0.508758722s s2n_quic:client:conn: key_space_discarded: space=Handshake id=0 0.508778479s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=38.827ms latest_rtt=31.225ms rtt_variance=19.4135ms max_ack_delay=25ms pto_count=0 congestion_window=13886 bytes_in_flight=282 congestion_limited=false id=0 0.508919974s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ping id=0 0.508955520s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Padding id=0 0.508986288s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1472 id=0 0.509001456s s2n_quic:client:conn: datagram_sent: len=1472 gso_offset=0 id=0 0.509035590s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 0.509053564s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 3 } path_id=0 ack_range=1..=1 id=0 0.509072249s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=NewConnectionId { sequence_number: 1, retire_prior_to: 1 } id=0 0.509086045s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=NewConnectionId { sequence_number: 2, retire_prior_to: 1 } id=0 0.509118876s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=104 id=0 0.509135707s s2n_quic:client:conn: datagram_sent: len=104 gso_offset=0 id=0 0.509166445s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=38.827ms latest_rtt=31.225ms rtt_variance=19.4135ms max_ack_delay=25ms pto_count=0 congestion_window=13886 bytes_in_flight=1625 congestion_limited=false id=0 0.509217019s s2n_quic:client: platform_event_loop_sleep: timeout=Some(141.165ms) processing_duration=916µs 0.509703440s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.509735700s s2n_quic:client: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.509748895s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.509782287s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.509813455s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 0.509834225s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 0.509856075s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } ack_range=0..=1 id=0 0.509907301s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 39.295ms, delivered_bytes: 94, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1321, bytes_in_flight: 278, prior_lost_bytes: 138, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 2392 } id=0 0.509935684s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=37.962875ms latest_rtt=31.931ms rtt_variance=16.288375ms max_ack_delay=25ms pto_count=0 congestion_window=13935 bytes_in_flight=1576 congestion_limited=false id=0 0.509963186s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 1157, is_fin: false } id=0 0.510021214s s2n_quic:client:conn: rx_stream_progress: bytes=1157 id=0 0.510074584s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.695ms) processing_duration=372µs 0.510639080s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.510697620s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.510733307s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.510764645s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 0.510784623s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Stream { id: 0, offset: 1157, len: 1160, is_fin: false } id=0 0.510830559s s2n_quic:client:conn: rx_stream_progress: bytes=1160 id=0 0.510872878s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.896ms) processing_duration=236µs 0.521142093s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.521186967s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.521231841s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.521273980s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 0.521300710s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Stream { id: 0, offset: 2317, len: 1160, is_fin: false } id=0 0.521361624s s2n_quic:client:conn: rx_stream_progress: bytes=1160 id=0 0.521418470s s2n_quic:client: platform_event_loop_sleep: timeout=Some(13.351ms) processing_duration=279µs 0.522124391s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.522168204s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.522212747s s2n_quic:client:conn: datagram_received: len=1200 id=0 0.522254485s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 0.522280894s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Stream { id: 0, offset: 3477, len: 1160, is_fin: false } id=0 0.522348230s s2n_quic:client:conn: rx_stream_progress: bytes=1160 id=0 0.522406820s s2n_quic:client: platform_event_loop_sleep: timeout=Some(12.363ms) processing_duration=285µs 0.522575736s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.522604300s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.522637011s s2n_quic:client:conn: datagram_received: len=523 id=0 0.522667919s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 0.522714916s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Stream { id: 0, offset: 4637, len: 483, is_fin: true } id=0 0.522766663s s2n_quic:client:conn: rx_stream_progress: bytes=483 id=0 0.522810515s s2n_quic:client: platform_event_loop_sleep: timeout=Some(11.958ms) processing_duration=238µs 0.523009808s 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.523078677s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=ConnectionClose id=0 0.523113522s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Padding id=0 0.523152355s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=45 id=0 0.523279212s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.523319438s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.523348662s s2n_quic:client: platform_event_loop_sleep: timeout=Some(11.42ms) processing_duration=71µs 0.534552345s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.534593152s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.534629620s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0xd99f64338258f96c87106b4c47ab0d0e, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=37.962875ms latest_rtt=31.931ms rtt_variance=16.288375ms max_ack_delay=25ms pto_count=0 congestion_window=13935 bytes_in_flight=1576 congestion_limited=false id=0 0.534715531s s2n_quic:client: platform_event_loop_sleep: timeout=Some(102.303ms) processing_duration=164µs 0.541064310s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.541108363s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.541153457s s2n_quic:client:conn: datagram_received: len=41 id=0 0.541197119s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 7 } id=0 0.541217918s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0xd99f64338258f96c87106b4c47ab0d0e current=0x30cee0df0eb23c38b38f2e956ae19a32 id=0 0.541246782s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 0.541275005s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } ack_range=0..=3 id=0 0.541304711s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1472 cause=ProbeAcknowledged search_complete=false id=0 0.541348242s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.772ms, delivered_bytes: 1625, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1366, bytes_in_flight: 1625, prior_lost_bytes: 138, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 49585 } id=0 0.541383327s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=37.246638ms latest_rtt=32.233ms rtt_variance=13.648747ms max_ack_delay=25ms pto_count=0 congestion_window=17959 bytes_in_flight=0 congestion_limited=false id=0 0.541425777s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } frame=RetireConnectionId id=0 0.541509333s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.629ms) processing_duration=446µs 0.566692584s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.566743098s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=37.246638ms latest_rtt=32.233ms rtt_variance=13.648747ms max_ack_delay=25ms pto_count=0 congestion_window=17959 bytes_in_flight=0 congestion_limited=false id=0 0.566791158s s2n_quic:client: platform_event_loop_sleep: timeout=Some(6.276ms) processing_duration=101µs 0.573920959s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.573973027s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=37.246638ms latest_rtt=32.233ms rtt_variance=13.648747ms max_ack_delay=25ms pto_count=0 congestion_window=17959 bytes_in_flight=0 congestion_limited=false id=0 0.574026727s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.574068755s s2n_quic:client: platform_event_loop_sleep: timeout=Some(78.807ms) processing_duration=149µs 0.652445050s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.652496116s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.652547081s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=37.246638ms latest_rtt=32.233ms rtt_variance=13.648747ms max_ack_delay=25ms pto_count=0 congestion_window=17959 bytes_in_flight=0 congestion_limited=false id=0 0.652612954s s2n_quic:client: platform_event_loop_sleep: timeout=Some(254.722ms) processing_duration=171µs 0.908125252s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.908198319s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:43797, local_cid: 0x30cee0df0eb23c38b38f2e956ae19a32, remote_addr: 193.167.100.100:443, remote_cid: 0xb773f33dea390db0, id: 0, is_active: true } min_rtt=31.225ms smoothed_rtt=37.246638ms latest_rtt=32.233ms rtt_variance=13.648747ms max_ack_delay=25ms pto_count=0 congestion_window=17959 bytes_in_flight=0 congestion_limited=false id=0 0.908364961s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=243µs