0.046579909s s2n_quic:client: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.046747332s s2n_quic:client: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.046764264s s2n_quic:client: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.046773942s s2n_quic:client: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.046870312s s2n_quic:client: platform_feature_configured: configuration=Gro { enabled: true } 0.046892894s s2n_quic:client: platform_feature_configured: configuration=Ecn { enabled: true } 0.048390191s s2n_quic:client: platform_event_loop_started: local_address=[::]:58530 0.048572161s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.048618006s s2n_quic:client: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.048665495s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=99µs 0.049485958s s2n_quic:client:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 0.049588028s s2n_quic:client:conn: connection_started: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, id: 0, is_active: true } id=0 0.049618024s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1252 cause=NewPath search_complete=false id=0 0.049792510s s2n_quic:client:conn: server_name_information: chosen_server_name="server4" id=0 0.049895172s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 0.050040834s 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.050084546s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Padding id=0 0.050138436s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=1252 id=0 0.050159125s s2n_quic:client:conn: datagram_sent: len=1252 gso_offset=0 id=0 0.050201865s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, 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.050272607s s2n_quic:client: platform_event_loop_sleep: timeout=Some(998.652ms) processing_duration=376µs 1.049782877s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.049904424s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.050005001s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=0ns pto_count=1 congestion_window=12520 bytes_in_flight=1252 congestion_limited=false id=0 1.050120096s s2n_quic:client:conn: packet_skipped: number=1 space=Initial reason=PtoProbe id=0 1.050194685s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 2, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 287 } id=0 1.050240531s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 2, version: 1 } path_id=0 frame=Padding id=0 1.050304941s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 2, version: 1 } packet_len=1200 id=0 1.050334456s s2n_quic:client:conn: datagram_sent: len=1200 gso_offset=0 id=0 1.050407372s s2n_quic:client:conn: packet_skipped: number=3 space=Initial reason=PtoProbe id=0 1.050520354s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 4, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 287 } id=0 1.050570757s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 4, version: 1 } path_id=0 frame=Padding id=0 1.050603098s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 4, version: 1 } packet_len=1200 id=0 1.050619559s s2n_quic:client:conn: datagram_sent: len=1200 gso_offset=0 id=0 1.050657660s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 0.0.0.0:0, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=0ns pto_count=1 congestion_window=12520 bytes_in_flight=3652 congestion_limited=false id=0 1.050740474s s2n_quic:client: platform_event_loop_sleep: timeout=Some(1.997353s) processing_duration=974µs 1.559101729s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.559212295s s2n_quic:client: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.559232713s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.559364479s s2n_quic:client:conn: datagram_received: len=1252 id=0 1.559479013s s2n_quic:client:conn: packet_received: packet_header=Initial { number: 0, version: 1 } id=0 1.559543433s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 1.559598256s s2n_quic:client:conn: ack_range_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, id: 0, is_active: true } ack_range=0..=0 id=0 1.559632660s s2n_quic:client:conn: mtu_updated: path_id=0 mtu=1252 cause=InitialMtuPacketAcknowledged search_complete=false id=0 1.559686851s s2n_quic:client:conn: pacing_rate_updated: path_id=0 bytes_per_second=22747 burst_size=12520 pacing_gain=2.77 id=0 1.559742916s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.509349s, 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: 829 } id=0 1.559777931s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=0ns pto_count=1 congestion_window=13772 bytes_in_flight=2400 congestion_limited=false id=0 1.559811734s s2n_quic:client:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xf4f95f8396dbe39a, id: 0, is_active: true } frame=Crypto { offset: 0, len: 123 } id=0 1.559867468s s2n_quic:client:conn: tls_server_hello: payload=[[3, 3, 3, 107, 154, 86, 46, 73, 91, 1, 158, 84, 108, 206, 243, 5, 223, 122, 38, 99, 133, 28, 71, 100, 145, 192, 120, 146, 182, 159, 161, 106, 61, 104, 0, 19, 1, 0, 0, 79, 0, 51, 0, 69, 0, 23, 0, 65, 4, 174, 135, 9, 54, 45, 58, 57, 26, 251, 37, 122, 133, 206, 67, 82, 234, 110, 1, 4, 232, 58, 184, 98, 204, 130, 186, 17, 21, 100, 60, 144, 62, 90, 191, 191, 50, 232, 160, 196, 162, 37, 26, 11, 100, 96, 52, 52, 203, 162, 43, 79, 22, 101, 9, 212, 207, 113, 30, 254, 151, 32, 29, 166, 38, 0, 43, 0, 2, 3, 4]] id=0 1.560241677s s2n_quic:client:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.560354818s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 1, version: 1 } id=0 1.560393711s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 1, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Crypto { offset: 0, len: 709 } id=0 1.560455116s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 1, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Padding id=0 1.560943878s s2n_quic:client:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.560976269s s2n_quic:client:conn: key_exchange_group: chosen_group_name="secp256r1" contains_kem=false id=0 1.561023357s s2n_quic:client:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: Some(0xf4f95f8396dbe39a), initial_source_connection_id: Some(0xbc00bcbf0ffff3a8), retry_source_connection_id: None, stateless_reset_token: Some([51, 114, 49, 210, 202, 67, 102, 155, 208, 99, 231, 37, 81, 172, 227, 229]), preferred_address: None, migration_support: true, max_idle_timeout: 30s, ack_delay_exponent: 3, max_ack_delay: 25ms, max_udp_payload_size: 65527, active_connection_id_limit: 8, initial_max_stream_data_bidi_local: 0, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 12288, initial_max_streams_bidi: 100, initial_max_streams_uni: 3, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 1.561123013s s2n_quic:client:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.561221887s s2n_quic:client:conn: handshake_status_updated: status=Complete id=0 1.561243297s s2n_quic:client:conn: tls_exporter_ready: session=TlsSession { .. } id=0 1.561395431s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 5, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 1, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 1.561428663s s2n_quic:client:conn: ack_range_sent: packet_header=Initial { number: 5, version: 1 } path_id=0 ack_range=0..=0 id=0 1.561472756s s2n_quic:client:conn: frame_sent: packet_header=Initial { number: 5, version: 1 } path_id=0 frame=Padding id=0 1.561504865s s2n_quic:client:conn: packet_sent: packet_header=Initial { number: 5, version: 1 } packet_len=70 id=0 1.561532147s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 1, ce_count: 0 }), largest_acknowledged: 1, ack_range_count: 1 } id=0 1.561547896s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 ack_range=1..=1 id=0 1.561569867s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 36 } id=0 1.561598981s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 1.561626082s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1182 id=0 1.561644196s s2n_quic:client:conn: key_space_discarded: space=Initial id=0 1.561657841s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=3582 congestion_limited=false id=0 1.561736318s s2n_quic:client:conn: datagram_sent: len=1252 gso_offset=0 id=0 1.561776553s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=1182 congestion_limited=false id=0 1.561830925s s2n_quic:client: platform_event_loop_sleep: timeout=Some(4.527554s) processing_duration=2.747ms 1.562179656s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.562216174s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.562290492s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Stream { id: 0, offset: 0, len: 0, is_fin: false } id=0 1.562349062s 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 1.562412130s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=49 id=0 1.562465259s s2n_quic:client:conn: datagram_sent: len=49 gso_offset=0 id=0 1.562516254s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=1231 congestion_limited=false id=0 1.562550809s s2n_quic:client:conn: tx_stream_progress: bytes=17 id=0 1.562583229s s2n_quic:client: platform_event_loop_sleep: timeout=Some(4.526801s) processing_duration=406µs 1.859639292s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.859737745s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.859754787s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.859839806s s2n_quic:client:conn: datagram_received: len=1252 id=0 1.859908203s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 3, version: 1 } id=0 1.859938600s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 3, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Crypto { offset: 0, len: 709 } id=0 1.859989235s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 3, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Padding id=0 1.860165824s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 2, ce_count: 0 }), largest_acknowledged: 3, ack_range_count: 2 } id=0 1.860196352s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 ack_range=3..=3 id=0 1.860210558s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 ack_range=1..=1 id=0 1.860230405s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 frame=Padding id=0 1.860262325s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 1, version: 1 } packet_len=69 id=0 1.860293202s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 1.860330242s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=1231 congestion_limited=false id=0 1.860388591s s2n_quic:client: platform_event_loop_sleep: timeout=Some(4.228997s) processing_duration=764µs 2.160284581s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.160388766s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.160408613s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.160537043s s2n_quic:client:conn: datagram_received: len=1252 id=0 2.160611702s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 5, version: 1 } id=0 2.160641157s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 5, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Crypto { offset: 0, len: 709 } id=0 2.160688686s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 5, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Padding id=0 2.160844386s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 3, ce_count: 0 }), largest_acknowledged: 5, ack_range_count: 3 } id=0 2.160874282s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 ack_range=5..=5 id=0 2.160887968s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 ack_range=3..=3 id=0 2.160900271s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 ack_range=1..=1 id=0 2.160919266s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 frame=Padding id=0 2.160952628s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 2, version: 1 } packet_len=69 id=0 2.160984308s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 2.161021307s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=1231 congestion_limited=false id=0 2.161091347s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.928294s) processing_duration=822µs 2.552909272s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.553016232s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.553036559s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.553125997s s2n_quic:client:conn: datagram_received: len=62 id=0 2.553230922s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.536156s) processing_duration=337µs 2.553400619s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.553463246s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.553508270s s2n_quic:client:conn: datagram_received: len=64 id=0 2.553559907s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.535825s) processing_duration=160µs 2.761004293s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.761099922s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.761189469s s2n_quic:client:conn: datagram_received: len=1252 id=0 2.761257276s s2n_quic:client:conn: packet_received: packet_header=Handshake { number: 9, version: 1 } id=0 2.761284627s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 9, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Crypto { offset: 0, len: 709 } id=0 2.761337305s s2n_quic:client:conn: frame_received: packet_header=Handshake { number: 9, version: 1 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Padding id=0 2.761533712s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 4, ce_count: 0 }), largest_acknowledged: 9, ack_range_count: 4 } id=0 2.761568036s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 ack_range=9..=9 id=0 2.761582262s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 ack_range=5..=5 id=0 2.761594175s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 ack_range=3..=3 id=0 2.761605947s s2n_quic:client:conn: ack_range_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 ack_range=1..=1 id=0 2.761625243s s2n_quic:client:conn: frame_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 frame=Padding id=0 2.761656301s s2n_quic:client:conn: packet_sent: packet_header=Handshake { number: 3, version: 1 } packet_len=69 id=0 2.761688821s s2n_quic:client:conn: datagram_sent: len=69 gso_offset=0 id=0 2.761725620s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=1231 congestion_limited=false id=0 2.761802163s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.327583s) processing_duration=812µs 3.065196407s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 3.065301193s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 3.065320789s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 3.065403584s s2n_quic:client:conn: datagram_received: len=611 id=0 3.065521734s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 10 } id=0 3.065564755s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Crypto { offset: 0, len: 572 } id=0 3.065621751s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=HandshakeDone id=0 3.065650345s s2n_quic:client:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 3.065664251s s2n_quic:client:conn: handshake_status_updated: status=Confirmed id=0 3.065878741s s2n_quic:client:conn: key_space_discarded: space=Handshake id=0 3.065912554s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=1231 congestion_limited=false id=0 3.066155187s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 1, ce_count: 0 }), largest_acknowledged: 10, ack_range_count: 1 } id=0 3.066191696s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 1 } path_id=0 ack_range=10..=10 id=0 3.066221040s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 1, retire_prior_to: 1 } id=0 3.066239976s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 2, retire_prior_to: 1 } id=0 3.066256967s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 3.066311229s s2n_quic:client:conn: ecn_state_changed: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } state=Unknown id=0 3.066335835s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=143 id=0 3.066349771s s2n_quic:client:conn: datagram_sent: len=143 gso_offset=0 id=0 3.066386469s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.509349s smoothed_rtt=1.509349s latest_rtt=1.509349s rtt_variance=754.6745ms max_ack_delay=25ms pto_count=0 congestion_window=13772 bytes_in_flight=192 congestion_limited=false id=0 3.066477339s s2n_quic:client: platform_event_loop_sleep: timeout=Some(4.552671s) processing_duration=1.296ms 3.066642077s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 3.066685357s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 3.066699343s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 3.066737324s s2n_quic:client:conn: datagram_received: len=1225 id=0 3.066772480s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 12 } id=0 3.066795713s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 3.066826401s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } ack_range=0..=0 id=0 3.066906390s s2n_quic:client:conn: ecn_state_changed: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } state=Failed id=0 3.066934002s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.512321s, delivered_bytes: 49, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1252, bytes_in_flight: 1231, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 32 } id=0 3.066964499s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } min_rtt=1.504476s smoothed_rtt=1.508739875s latest_rtt=1.504476s rtt_variance=567.224125ms max_ack_delay=25ms pto_count=0 congestion_window=13821 bytes_in_flight=143 congestion_limited=false id=0 3.066994164s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0xbc00bcbf0ffff3a8, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 3.067035692s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0xbc00bcbf0ffff3a8 current=0x3a0c9badf19b9c37 id=0 3.067057582s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 3.067085144s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewToken id=0 3.067106534s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 1024, is_fin: true } id=0 3.067161055s s2n_quic:client:conn: rx_stream_progress: bytes=1024 id=0 3.067225746s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ping id=0 3.067258307s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Padding id=0 3.067287602s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1472 id=0 3.067302470s s2n_quic:client:conn: datagram_sent: len=1472 gso_offset=0 id=0 3.067335231s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 2, ce_count: 0 }), largest_acknowledged: 12, ack_range_count: 2 } id=0 3.067353345s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 3 } path_id=0 ack_range=12..=12 id=0 3.067365608s s2n_quic:client:conn: ack_range_sent: packet_header=OneRtt { number: 3 } path_id=0 ack_range=10..=10 id=0 3.067384403s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=RetireConnectionId id=0 3.067410060s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Padding id=0 3.067457188s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=45 id=0 3.067478508s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 3.067512812s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.504476s smoothed_rtt=1.508739875s latest_rtt=1.504476s rtt_variance=567.224125ms max_ack_delay=25ms pto_count=0 congestion_window=13821 bytes_in_flight=1660 congestion_limited=false id=0 3.067570410s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.802274s) processing_duration=930µs 3.067867234s 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 3.067935031s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=ConnectionClose id=0 3.067966029s s2n_quic:client:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Padding id=0 3.068001224s s2n_quic:client:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=45 id=0 3.068059443s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 3.068088127s s2n_quic:client: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 3.068125156s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 3.068156194s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.801687s) processing_duration=98µs 3.428720700s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 3.428821819s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 3.428842347s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 3.428952393s s2n_quic:client:conn: datagram_dropped: local_addr=193.167.0.100:58530 remote_addr=[::ffff:193.167.100.100]:443 destination_cid=0x0e4e2c06ecb676692294629ac3d243f3 source_cid=Some(0xbc00bcbf0ffff3a8) len=1065 reason=InvalidSourceConnectionId id=0 3.429036189s s2n_quic:client: platform_event_loop_sleep: timeout=Some(3.44081s) processing_duration=332µs 3.732641222s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 3.732738794s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 3.732836887s s2n_quic:client:conn: datagram_received: len=42 id=0 3.732912809s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 14 } id=0 3.732952974s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 14 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 3.732994922s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 14 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } ack_range=0..=0 id=0 3.733025910s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.504476s smoothed_rtt=1.508739875s latest_rtt=1.504476s rtt_variance=567.224125ms max_ack_delay=25ms pto_count=0 congestion_window=13821 bytes_in_flight=1660 congestion_limited=false id=0 3.733151494s s2n_quic:client: platform_event_loop_sleep: timeout=Some(1.504119s) processing_duration=523µs 3.733331420s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 3.733364131s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 3.733404918s s2n_quic:client:conn: datagram_received: len=1162 id=0 3.733472293s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 15 } id=0 3.733508160s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 3.733553014s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 3.733581087s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewToken id=0 3.733602386s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 1024, is_fin: true } id=0 3.733669542s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.721ms) processing_duration=339µs 3.758942349s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 3.759110724s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.504476s smoothed_rtt=1.508739875s latest_rtt=1.504476s rtt_variance=567.224125ms max_ack_delay=25ms pto_count=0 congestion_window=13821 bytes_in_flight=1660 congestion_limited=false id=0 3.759209438s s2n_quic:client: platform_event_loop_sleep: timeout=Some(1.478061s) processing_duration=282µs 4.096218650s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 4.096312976s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 4.096404918s s2n_quic:client:conn: datagram_dropped: local_addr=193.167.0.100:58530 remote_addr=[::ffff:193.167.100.100]:443 destination_cid=0x0e4e2c06ecb676692294629ac3d243f3 source_cid=Some(0xbc00bcbf0ffff3a8) len=1124 reason=InvalidSourceConnectionId id=0 4.096523960s s2n_quic:client: platform_event_loop_sleep: timeout=Some(1.140746s) processing_duration=319µs 4.232927970s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 4.233029890s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 4.233117213s s2n_quic:client:conn: datagram_received: len=42 id=0 4.233187735s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 18 } id=0 4.233229162s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 4.233268876s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } ack_range=0..=0 id=0 4.233300916s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.504476s smoothed_rtt=1.508739875s latest_rtt=1.504476s rtt_variance=567.224125ms max_ack_delay=25ms pto_count=0 congestion_window=13821 bytes_in_flight=1660 congestion_limited=false id=0 4.233411212s s2n_quic:client: platform_event_loop_sleep: timeout=Some(1.003858s) processing_duration=497µs 4.233526758s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 4.233556513s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 4.233590938s s2n_quic:client:conn: datagram_received: len=611 id=0 4.233624040s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 19 } id=0 4.233647323s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=Crypto { offset: 0, len: 572 } id=0 4.233670426s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=HandshakeDone id=0 4.233752419s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.827ms) processing_duration=226µs 4.234170941s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 4.234218149s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 4.234255288s s2n_quic:client:conn: datagram_received: len=1162 id=0 4.234290935s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 20 } id=0 4.234315180s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 4.234374240s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 4.234403906s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=NewToken id=0 4.234424605s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 1024, is_fin: true } id=0 4.234510084s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.07ms) processing_duration=340µs 4.259731265s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 4.259845188s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0x0e4e2c06ecb676692294629ac3d243f3, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.504476s smoothed_rtt=1.508739875s latest_rtt=1.504476s rtt_variance=567.224125ms max_ack_delay=25ms pto_count=0 congestion_window=13821 bytes_in_flight=1660 congestion_limited=false id=0 4.259918745s s2n_quic:client: platform_event_loop_sleep: timeout=Some(977.35ms) processing_duration=198µs 4.567868962s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 4.567962506s s2n_quic:client: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 4.568049138s s2n_quic:client:conn: datagram_received: len=42 id=0 4.568112877s s2n_quic:client:conn: packet_received: packet_header=OneRtt { number: 21 } id=0 4.568132193s s2n_quic:client:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x0e4e2c06ecb676692294629ac3d243f3 current=0xa91dcff0c885ee399dacf542d3e70c65 id=0 4.568165125s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 21 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 4.568196073s s2n_quic:client:conn: ack_range_received: packet_header=OneRtt { number: 21 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } ack_range=0..=1 id=0 4.568295969s s2n_quic:client:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.512321s, delivered_bytes: 192, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1252, bytes_in_flight: 1231, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 126 } id=0 4.568336334s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.501896s smoothed_rtt=1.507884388s latest_rtt=1.501896s rtt_variance=427.129061ms max_ack_delay=25ms pto_count=0 congestion_window=13964 bytes_in_flight=1517 congestion_limited=false id=0 4.568378162s s2n_quic:client:conn: frame_received: packet_header=OneRtt { number: 21 } path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } frame=RetireConnectionId id=0 4.568512243s s2n_quic:client: platform_event_loop_sleep: timeout=Some(24.489ms) processing_duration=655µs 4.593755738s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 4.593949409s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.501896s smoothed_rtt=1.507884388s latest_rtt=1.501896s rtt_variance=427.129061ms max_ack_delay=25ms pto_count=0 congestion_window=13964 bytes_in_flight=1517 congestion_limited=false id=0 4.594057311s s2n_quic:client: platform_event_loop_sleep: timeout=Some(643.213ms) processing_duration=316µs 5.238030718s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 5.238205304s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.501896s smoothed_rtt=1.507884388s latest_rtt=1.501896s rtt_variance=427.129061ms max_ack_delay=25ms pto_count=0 congestion_window=13964 bytes_in_flight=1517 congestion_limited=false id=0 5.238302676s s2n_quic:client:conn: datagram_sent: len=45 gso_offset=0 id=0 5.238363149s s2n_quic:client: platform_event_loop_sleep: timeout=Some(1.070248s) processing_duration=348µs 6.309864410s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 6.309967913s s2n_quic:client: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 6.310049916s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.501896s smoothed_rtt=1.507884388s latest_rtt=1.501896s rtt_variance=427.129061ms max_ack_delay=25ms pto_count=1 congestion_window=13964 bytes_in_flight=1517 congestion_limited=false id=0 6.310141507s s2n_quic:client: platform_event_loop_sleep: timeout=Some(2.781511s) processing_duration=293µs 9.093322916s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 9.093560890s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.501896s smoothed_rtt=1.507884388s latest_rtt=1.501896s rtt_variance=427.129061ms max_ack_delay=25ms pto_count=1 congestion_window=13964 bytes_in_flight=1517 congestion_limited=false id=0 9.093674442s s2n_quic:client: platform_event_loop_sleep: timeout=Some(456.337ms) processing_duration=367µs 9.551419191s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 9.551611199s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.501896s smoothed_rtt=1.507884388s latest_rtt=1.501896s rtt_variance=427.129061ms max_ack_delay=25ms pto_count=2 congestion_window=13964 bytes_in_flight=1517 congestion_limited=false id=0 9.551722597s s2n_quic:client: platform_event_loop_sleep: timeout=Some(4.924043s) processing_duration=318µs 14.477032068s s2n_quic:client: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 14.477186286s s2n_quic:client:conn: recovery_metrics: path=Path { local_addr: 193.167.0.100:58530, local_cid: 0xa91dcff0c885ee399dacf542d3e70c65, remote_addr: 193.167.100.100:443, remote_cid: 0x3a0c9badf19b9c37, id: 0, is_active: true } min_rtt=1.501896s smoothed_rtt=1.507884388s latest_rtt=1.501896s rtt_variance=427.129061ms max_ack_delay=25ms pto_count=2 congestion_window=13964 bytes_in_flight=1517 congestion_limited=false id=0 14.477398312s s2n_quic:client: platform_event_loop_sleep: timeout=None processing_duration=380µs