0.046806397s s2n_quic:client: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.047001090s s2n_quic:client: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.047031958s s2n_quic:client: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.047050703s s2n_quic:client: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.047157352s s2n_quic:client: platform_feature_configured: configuration=Gro { enabled: true } 0.047183811s s2n_quic:client: platform_feature_configured: configuration=Ecn { enabled: true } 0.048820558s s2n_quic:client: platform_event_loop_started: local_address=[::]:58754 0.048932087s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.048958606s s2n_quic:client: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.049038074s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=104µs 0.049818883s s2n_quic:client:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.049900035s s2n_quic:client:conn: connection_started: path=Path { local_addr: 0.0.0.0:0, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, id: 0, is_active: true } id=0 0.049932064s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 0.050140814s s2n_quic:client:conn: server_name_information: chosen_server_name="server6" id=0 0.050247323s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.050380261s 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.050421829s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.050475980s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=1232 id=0 0.050495346s s2n_quic:client:conn: datagram_sent: len=1232 gso_offset=0 id=0 0.050535501s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 0.0.0.0:0, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, 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.050602406s s2n_quic:client: platform_event_loop_sleep: timeout=Some(998.672ms) processing_duration=355µs 0.091070286s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.091178969s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.091198986s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.091332556s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.091438363s s2n_quic:client:conn: packet_received: packet_header=Initial { number: 979828, version: 1 } id=0 0.091489349s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 979828, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, id: 0, is_active: true } frame=Crypto { offset: 0, len: 56 } id=0 0.091557456s s2n_quic:client:conn: tls_server_hello: payload=[[3, 3, 207, 33, 173, 116, 229, 154, 97, 17, 190, 29, 140, 2, 30, 101, 184, 145, 194, 162, 17, 22, 122, 187, 140, 94, 7, 158, 9, 226, 200, 168, 51, 156, 0, 19, 1, 0, 0, 12, 0, 43, 0, 2, 3, 4, 0, 51, 0, 2, 0, 29]] id=0 0.091608151s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 979828, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.091653515s s2n_quic:client:conn: ack_range_received: packet_header=Initial { number: 979828, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, id: 0, is_active: true } ack_range=0..=0 id=0 0.091683972s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1232 cause=InitialMtuPacketAcknowledged search_complete=false id=0 0.091736861s s2n_quic:client:conn: pacing_rate_updated: path_id=0 bytes_per_second=824551 burst_size=12320 pacing_gain=2.77 id=0 0.091781925s s2n_quic:client:conn: ecn_state_changed: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, id: 0, is_active: true } state=Failed id=0 0.091809056s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 40.974ms, 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: 30067 } id=0 0.091844341s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, id: 0, is_active: true } min_rtt=40.974ms smoothed_rtt=40.974ms latest_rtt=40.974ms rtt_variance=20.487ms max_ack_delay=0ns pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 0.091903913s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 979828, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x496c343a46d4b2b6, id: 0, is_active: true } frame=Padding id=0 0.092221386s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 979828, ack_range_count: 1 } id=0 0.092260128s s2n_quic:client:conn: ack_range_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 ack_range=979828..=979828 id=0 0.092286257s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Crypto { offset: 287, len: 254 } id=0 0.092311163s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 1, version: 1 } path_id=0 frame=Padding id=0 0.092344716s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 1, version: 1 } packet_len=1232 id=0 0.092361317s s2n_quic:client:conn: datagram_sent: len=1232 gso_offset=0 id=0 0.092393988s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=40.974ms smoothed_rtt=40.974ms latest_rtt=40.974ms rtt_variance=20.487ms max_ack_delay=0ns pto_count=0 congestion_window=13552 bytes_in_flight=1232 congestion_limited=false id=0 0.092459350s s2n_quic:client: platform_event_loop_sleep: timeout=Some(122.635ms) processing_duration=1.407ms 0.125875089s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.126017956s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.126042101s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.126130937s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.126191710s s2n_quic:client:conn: packet_received: packet_header=Initial { number: 979829, version: 1 } id=0 0.126218400s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 979829, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=Crypto { offset: 56, len: 90 } id=0 0.126267492s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 979829, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 0.126293721s s2n_quic:client:conn: ack_range_received: packet_header=Initial { number: 979829, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } ack_range=1..=1 id=0 0.126365896s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.907ms, delivered_bytes: 1232, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 36334 } id=0 0.126402925s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=33.907ms smoothed_rtt=40.974ms latest_rtt=33.907ms rtt_variance=20.487ms max_ack_delay=0ns pto_count=0 congestion_window=14784 bytes_in_flight=0 congestion_limited=false id=0 0.126455002s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 979829, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=Padding id=0 0.126749542s s2n_quic:client:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.126914681s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 2, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 979829, ack_range_count: 1 } id=0 0.126943074s s2n_quic:client:conn: ack_range_sent: packet_header=Initial { number: 2, version: 1 } path_id=0 ack_range=979829..=979829 id=0 0.126984642s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 2, version: 1 } path_id=0 frame=Padding id=0 0.127020839s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 2, version: 1 } packet_len=1232 id=0 0.127056085s s2n_quic:client:conn: key_space_discarded: space=Initial id=0 0.127070061s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=33.907ms smoothed_rtt=40.974ms latest_rtt=33.907ms rtt_variance=20.487ms max_ack_delay=0ns pto_count=0 congestion_window=14784 bytes_in_flight=0 congestion_limited=false id=0 0.127134631s s2n_quic:client:conn: datagram_sent: len=1232 gso_offset=0 id=0 0.127167433s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=33.907ms smoothed_rtt=40.974ms latest_rtt=33.907ms rtt_variance=20.487ms max_ack_delay=0ns pto_count=0 congestion_window=14784 bytes_in_flight=0 congestion_limited=false id=0 0.127219851s s2n_quic:client: platform_event_loop_sleep: timeout=Some(122.561ms) processing_duration=1.36ms 0.127344413s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.127372416s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.127385280s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.127420726s s2n_quic:client:conn: datagram_received: len=769 id=0 0.127457505s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 979828, version: 1 } id=0 0.127479606s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 979828, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=Crypto { offset: 0, len: 713 } id=0 0.127959973s s2n_quic:client:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 0.128012872s s2n_quic:client:conn: key_exchange_group: chosen_group_name="x25519" contains_kem=false id=0 0.128061533s s2n_quic:client:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: Some(0x496c343a46d4b2b6), initial_source_connection_id: Some(0x400000cff68ab470), retry_source_connection_id: None, stateless_reset_token: Some([23, 186, 94, 120, 220, 231, 94, 32, 178, 123, 200, 255, 48, 138, 245, 142]), preferred_address: None, migration_support: true, max_idle_timeout: 60s, ack_delay_exponent: 3, max_ack_delay: 25ms, max_udp_payload_size: 1500, active_connection_id_limit: 2, initial_max_stream_data_bidi_local: 262144, initial_max_stream_data_bidi_remote: 262144, initial_max_stream_data_uni: 262144, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, max_datagram_frame_size: 65535, dc_supported_versions: [] } id=0 0.128149727s s2n_quic:client:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.128243352s s2n_quic:client:conn: handshake_status_updated: status=Complete id=0 0.128265133s s2n_quic:client:conn: tls_exporter_ready: session=TlsSession { .. } id=0 0.128366743s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 979828, ack_range_count: 1 } id=0 0.128393162s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 ack_range=979828..=979828 id=0 0.128415714s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 36 } id=0 0.128449667s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=98 id=0 0.128496104s s2n_quic:client:conn: datagram_sent: len=98 gso_offset=0 id=0 0.128531340s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=33.907ms smoothed_rtt=40.974ms latest_rtt=33.907ms rtt_variance=20.487ms max_ack_delay=25ms pto_count=0 congestion_window=14784 bytes_in_flight=98 congestion_limited=false id=0 0.128591182s s2n_quic:client: platform_event_loop_sleep: timeout=Some(122.671ms) processing_duration=1.248ms 0.129123356s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.129170524s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.129248680s 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.129313441s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 0.129341363s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 4, offset: 0, len: 17, is_fin: true } id=0 0.129386467s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=69 id=0 0.129404110s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 0.129441049s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=33.907ms smoothed_rtt=40.974ms latest_rtt=33.907ms rtt_variance=20.487ms max_ack_delay=25ms pto_count=0 congestion_window=14784 bytes_in_flight=167 congestion_limited=false id=0 0.129474932s s2n_quic:client:conn: tx_stream_progress: bytes=34 id=0 0.129507323s s2n_quic:client: platform_event_loop_sleep: timeout=Some(121.754ms) processing_duration=389µs 0.159618190s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.159717114s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.159737122s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.159820187s s2n_quic:client:conn: datagram_received: len=54 id=0 0.159883485s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 979829, version: 1 } id=0 0.159916326s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 979829, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.159997388s s2n_quic:client:conn: ack_range_received: packet_header=Handshake { number: 979829, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } ack_range=0..=0 id=0 0.160091173s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 31.433ms, delivered_bytes: 98, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 2464, bytes_in_flight: 98, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 3117 } id=0 0.160136007s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=40.974ms latest_rtt=31.433ms rtt_variance=20.487ms max_ack_delay=25ms pto_count=0 congestion_window=14882 bytes_in_flight=69 congestion_limited=false id=0 0.160361317s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=40.974ms latest_rtt=31.433ms rtt_variance=20.487ms max_ack_delay=25ms pto_count=0 congestion_window=14882 bytes_in_flight=69 congestion_limited=false id=0 0.160432070s s2n_quic:client: platform_event_loop_sleep: timeout=Some(59.93082s) processing_duration=827µs 0.160558886s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.160585446s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.160623187s s2n_quic:client:conn: datagram_received: len=368 id=0 0.160662790s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979828 } id=0 0.160690392s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979828 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=Crypto { offset: 0, len: 250 } id=0 0.160730657s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979828 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=HandshakeDone id=0 0.160754953s s2n_quic:client:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 0.160766274s s2n_quic:client:conn: handshake_status_updated: status=Confirmed id=0 0.160791441s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979828 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000cff68ab470, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 0.160844670s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0x400000cff68ab470 current=0x400000d5fd0949ab id=0 0.160882050s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979828 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 0.160923878s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979828 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Padding id=0 0.161147375s s2n_quic:client:conn: key_space_discarded: space=Handshake id=0 0.161179445s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=40.974ms latest_rtt=31.433ms rtt_variance=20.487ms max_ack_delay=25ms pto_count=0 congestion_window=14882 bytes_in_flight=69 congestion_limited=false id=0 0.161311312s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ping id=0 0.161352288s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Padding id=0 0.161389187s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=1452 id=0 0.161405407s s2n_quic:client:conn: datagram_sent: len=1452 gso_offset=0 id=0 0.161445833s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 979828, ack_range_count: 1 } id=0 0.161464868s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 2 } path_id=0 ack_range=979828..=979828 id=0 0.161486559s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=NewConnectionId { sequence_number: 1, retire_prior_to: 1 } id=0 0.161500535s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=NewConnectionId { sequence_number: 2, retire_prior_to: 1 } id=0 0.161517657s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=RetireConnectionId id=0 0.161561299s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=109 id=0 0.161579542s s2n_quic:client:conn: datagram_sent: len=109 gso_offset=0 id=0 0.161611873s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=40.974ms latest_rtt=31.433ms rtt_variance=20.487ms max_ack_delay=25ms pto_count=0 congestion_window=14882 bytes_in_flight=1630 congestion_limited=false id=0 0.161670863s s2n_quic:client: platform_event_loop_sleep: timeout=Some(147.542ms) processing_duration=1.112ms 0.161802950s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.161829940s s2n_quic:client: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.161842594s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.161876677s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.161908838s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979829 } id=0 0.161930438s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979829 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 0.161953802s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 979829 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } ack_range=0..=0 id=0 0.162058447s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 31.433ms, delivered_bytes: 167, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 2464, bytes_in_flight: 98, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 5312 } id=0 0.162093933s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=39.927625ms latest_rtt=32.657ms rtt_variance=17.458ms max_ack_delay=25ms pto_count=0 congestion_window=14951 bytes_in_flight=1561 congestion_limited=false id=0 0.162127857s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979829 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 1189, is_fin: false } id=0 0.162207766s s2n_quic:client:conn: rx_stream_progress: bytes=1189 id=0 0.162264141s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.598ms) processing_duration=462µs 0.162417939s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.162447884s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.162480886s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.162512615s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979830 } id=0 0.162531240s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979830 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 1194, is_fin: false } id=0 0.162598806s s2n_quic:client:conn: rx_stream_progress: bytes=1194 id=0 0.162643229s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.219ms) processing_duration=227µs 0.163419429s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.163451939s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.163485132s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.163516841s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979831 } id=0 0.163538181s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979831 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 0, offset: 1189, len: 1192, is_fin: false } id=0 0.163603402s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.163647024s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.215ms) processing_duration=229µs 0.164444243s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.164482564s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.164523541s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.164555420s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979832 } id=0 0.164574917s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979832 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 1194, len: 1192, is_fin: false } id=0 0.164658914s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.164711702s s2n_quic:client: platform_event_loop_sleep: timeout=Some(22.15ms) processing_duration=270µs 0.165467343s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.165499915s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.165540079s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.165572961s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979833 } id=0 0.165592407s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979833 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 0, offset: 2381, len: 1192, is_fin: false } id=0 0.165656567s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.165699758s s2n_quic:client: platform_event_loop_sleep: timeout=Some(21.162ms) processing_duration=234µs 0.166492658s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.166525931s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.166558882s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.166590601s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979834 } id=0 0.166609807s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979834 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 2386, len: 1192, is_fin: false } id=0 0.166674137s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.166717849s s2n_quic:client: platform_event_loop_sleep: timeout=Some(20.144ms) processing_duration=227µs 0.167521039s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.167553891s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.167587413s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.167619333s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979835 } id=0 0.167638869s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979835 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 0, offset: 3573, len: 1192, is_fin: false } id=0 0.167713238s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.167759064s s2n_quic:client: platform_event_loop_sleep: timeout=Some(19.103ms) processing_duration=240µs 0.168545262s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.168577863s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.168611015s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.168642283s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979836 } id=0 0.168661930s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979836 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 3578, len: 1192, is_fin: false } id=0 0.168731139s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.168776344s s2n_quic:client: platform_event_loop_sleep: timeout=Some(18.086ms) processing_duration=233µs 0.169571459s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.169610201s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.169644175s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.169675783s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979837 } id=0 0.169695480s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979837 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 0, offset: 4765, len: 355, is_fin: true } id=0 0.169734042s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979837 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 4770, len: 831, is_fin: false } id=0 0.169791510s s2n_quic:client:conn: rx_stream_progress: bytes=1186 id=0 0.169834921s s2n_quic:client: platform_event_loop_sleep: timeout=Some(17.027ms) processing_duration=265µs 0.170614096s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.170649672s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.170683065s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.170715355s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979838 } id=0 0.170735373s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979838 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 5601, len: 1192, is_fin: false } id=0 0.170801075s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.170880183s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 979838, ack_range_count: 1 } id=0 0.170907824s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 3 } path_id=0 ack_range=979828..=979838 id=0 0.170937630s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Padding id=0 0.170998444s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=45 id=0 0.171022679s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.171059167s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=39.927625ms latest_rtt=32.657ms rtt_variance=17.458ms max_ack_delay=25ms pto_count=0 congestion_window=14951 bytes_in_flight=1561 congestion_limited=false id=0 0.171115543s s2n_quic:client: platform_event_loop_sleep: timeout=Some(124.934ms) processing_duration=503µs 0.171657976s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.171703430s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.171717877s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.171764334s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.171827342s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979839 } id=0 0.171863710s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979839 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 6793, len: 1192, is_fin: false } id=0 0.171943749s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.172026564s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.712ms) processing_duration=373µs 0.172649968s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.172679974s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.172713497s s2n_quic:client:conn: datagram_received: len=1232 id=0 0.172745387s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979840 } id=0 0.172764883s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979840 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 7985, len: 1192, is_fin: false } id=0 0.172840123s s2n_quic:client:conn: rx_stream_progress: bytes=1192 id=0 0.172886490s s2n_quic:client: platform_event_loop_sleep: timeout=Some(23.851ms) processing_duration=238µs 0.173601936s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.173635018s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.173668140s s2n_quic:client:conn: datagram_received: len=1136 id=0 0.173699538s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979841 } id=0 0.173719676s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979841 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Stream { id: 4, offset: 9177, len: 1063, is_fin: true } id=0 0.173758789s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979841 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Padding id=0 0.173814323s s2n_quic:client:conn: rx_stream_progress: bytes=1063 id=0 0.173854588s s2n_quic:client: platform_event_loop_sleep: timeout=Some(22.882ms) processing_duration=255µs 0.174109755s 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.174187590s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=ConnectionClose id=0 0.174221754s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Padding id=0 0.174258973s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=45 id=0 0.174306853s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.174361044s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.174395769s s2n_quic:client: platform_event_loop_sleep: timeout=Some(22.341ms) processing_duration=90µs 0.193778750s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.193882754s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.193902951s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.194003880s s2n_quic:client:conn: datagram_received: len=80 id=0 0.194081926s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979842 } id=0 0.194117712s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979842 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 2, ack_range_count: 1 } id=0 0.194165301s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 979842 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } ack_range=0..=2 id=0 0.194204855s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 0.194288922s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 34.162ms, delivered_bytes: 1630, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 2562, bytes_in_flight: 1630, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 47713 } id=0 0.194328356s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=39.015921ms latest_rtt=32.645ms rtt_variance=14.916906ms max_ack_delay=25ms pto_count=0 congestion_window=19181 bytes_in_flight=0 congestion_limited=false id=0 0.194371517s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979842 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 0 } id=0 0.194415288s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979842 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=Padding id=0 0.194514323s s2n_quic:client: platform_event_loop_sleep: timeout=Some(2.224ms) processing_duration=752µs 0.196650012s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.196711617s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=39.015921ms latest_rtt=32.645ms rtt_variance=14.916906ms max_ack_delay=25ms pto_count=0 congestion_window=19181 bytes_in_flight=0 congestion_limited=false id=0 0.196773222s s2n_quic:client: platform_event_loop_sleep: timeout=Some(29.819ms) processing_duration=124µs 0.205194159s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.205283606s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.205359979s s2n_quic:client:conn: datagram_received: len=49 id=0 0.205418839s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 979843 } id=0 0.205459455s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 979843 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=ConnectionClose id=0 0.205494240s s2n_quic:client:conn: connection_close_frame_received: packet_header=OneRtt { number: 979843 } path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: Some(28), reason: Some("Peer closed") } id=0 0.205560503s s2n_quic:client: platform_event_loop_sleep: timeout=Some(21.032ms) processing_duration=380µs 0.226786997s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.226937158s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=39.015921ms latest_rtt=32.645ms rtt_variance=14.916906ms max_ack_delay=25ms pto_count=0 congestion_window=19181 bytes_in_flight=0 congestion_limited=false id=0 0.227065537s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 0.227122063s s2n_quic:client: platform_event_loop_sleep: timeout=Some(351.255ms) processing_duration=349µs 0.578912301s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 0.579064816s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 0.579142321s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:0:0:0:0:100]:58754, local_cid: 0xffa326cb5c214ee246cd1c930722f238, remote_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, remote_cid: 0x400000d5fd0949ab, id: 0, is_active: true } min_rtt=31.433ms smoothed_rtt=39.015921ms latest_rtt=32.645ms rtt_variance=14.916906ms max_ack_delay=25ms pto_count=0 congestion_window=19181 bytes_in_flight=0 congestion_limited=false id=0 0.579339118s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=441µs