2025/04/30 08:47:08 Requesting https://server6:443/uimvsgsbat.
2025/04/30 08:47:08 Requesting https://server6:443/brzkshksbh.
2025/04/30 08:47:08 Increased receive buffer size to 14336 kiB
2025/04/30 08:47:08 Increased send buffer size to 14336 kiB
2025/04/30 08:47:08 Setting DF for IPv4 and IPv6.
2025/04/30 08:47:08 Activating reading of ECN bits for IPv4 and IPv6.
2025/04/30 08:47:08 Activating reading of packet info for IPv4 and IPv6.
2025/04/30 08:47:08 Created qlog file: /logs/qlog/9bb867aa237018283de4b78159102158dbd6.sqlog
2025/04/30 08:47:08 client Starting new connection to server6 ([::]:42446 -> [fd00:cafe:cafe:100::100]:443), source connection ID (empty), destination connection ID 9bb867aa237018283de4b78159102158dbd6, version v1
2025/04/30 08:47:08 Adding connection ID (empty).
2025/04/30 08:47:08 client Not doing 0-RTT. Has sealer: false, has params: false
2025/04/30 08:47:08 client -> Sending packet 0 (1280 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, Initial
2025/04/30 08:47:08 client 	Long Header{Type: Initial, DestConnectionID: 9bb867aa237018283de4b78159102158dbd6, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 1252, Version: v1}
2025/04/30 08:47:08 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 262, Offset + Data length: 262}
2025/04/30 08:47:08 client Parsed a coalesced packet. Part 1: 135 bytes. Remaining: 1097 bytes.
2025/04/30 08:47:08 client <- Reading packet 0 (135 bytes) for connection (empty), Initial
2025/04/30 08:47:08 client 	Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: 99ebeefc81869c24, Token: (empty), PacketNumber: 0, PacketNumberLen: 1, Length: 117, Version: v1}
2025/04/30 08:47:08 client Received first packet. Switching destination connection ID to: 99ebeefc81869c24
2025/04/30 08:47:08 client 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 1.28ms}
2025/04/30 08:47:08 client 	newly acked packets (1): [0]
2025/04/30 08:47:08 client 	updated RTT: 41.309889ms (σ: 20.654944ms)
2025/04/30 08:47:08 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90}
2025/04/30 08:47:08 client Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:47:08 client Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:47:08 client Parsed a coalesced packet. Part 2: 1097 bytes. Remaining: 0 bytes.
2025/04/30 08:47:08 client <- Reading packet 1 (1097 bytes) for connection (empty), Handshake
2025/04/30 08:47:08 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 99ebeefc81869c24, PacketNumber: 1, PacketNumberLen: 1, Length: 1080, Version: v1}
2025/04/30 08:47:08 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 720, Offset + Data length: 720}
2025/04/30 08:47:08 client Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:47:08 client Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:47:08 client Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: 9bb867aa237018283de4b78159102158dbd6, InitialSourceConnectionID: 99ebeefc81869c24, InitialMaxStreamDataBidiLocal: 0, InitialMaxStreamDataBidiRemote: 1048576, InitialMaxStreamDataUni: 12288, InitialMaxData: 1572864, MaxBidiStreamNum: 100, MaxUniStreamNum: 3, MaxIdleTimeout: 30s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 8, StatelessResetToken: 0xb3664e9587c47ed47f1c77d73a0994ee}
2025/04/30 08:47:08 client -> Sending coalesced packet (2 parts, 1280 bytes) for connection 9bb867aa237018283de4b78159102158dbd6
2025/04/30 08:47:08 client 	Long Header{Type: Initial, DestConnectionID: 99ebeefc81869c24, SrcConnectionID: (empty), Token: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 1188, Version: v1}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s, ECT0: 0, ECT1: 1, CE: 0}
2025/04/30 08:47:08 client 	Long Header{Type: Handshake, DestConnectionID: 99ebeefc81869c24, SrcConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 57, Version: v1}
2025/04/30 08:47:08 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36}
2025/04/30 08:47:08 client Dropping Initial keys.
2025/04/30 08:47:08 client -> Sending packet 1 (43 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, Handshake
2025/04/30 08:47:08 client 	Long Header{Type: Handshake, DestConnectionID: 99ebeefc81869c24, SrcConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 26, Version: v1}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 1, LowestAcked: 1, DelayTime: 0s, ECT0: 0, ECT1: 1, CE: 0}
2025/04/30 08:47:08 client -> Sending packet 0 (66 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: ECT(0))
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 99ebeefc81869c24, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 08:47:08 client 	-> &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 08:47:08 client <- Reading packet 2 (21 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.HandshakeDoneFrame{}
2025/04/30 08:47:08 client Dropping Handshake keys.
2025/04/30 08:47:08 client 	Queueing ACK because the first packet should be acknowledged.
2025/04/30 08:47:08 client -> Sending packet 1 (35 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: ECT(0))
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 99ebeefc81869c24, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 2, LowestAcked: 2, DelayTime: 51.416µs, ECT0: 0, ECT1: 1, CE: 0}
2025/04/30 08:47:08 client Parsed a coalesced packet. Part 1: 39 bytes. Remaining: 158 bytes.
2025/04/30 08:47:08 client Dropping %!s(logging.PacketType=1) packet (39 bytes) because we already dropped the keys.
2025/04/30 08:47:08 client <- Reading packet 4 (158 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 1d2efae8c96fb9f3, StatelessResetToken: 0x43230bb5cfeb2de2084c854f660366d0}
2025/04/30 08:47:08 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 2abe4301f5cd894f, StatelessResetToken: 0xb05ea4308de8b016b5bbb3570978c46c}
2025/04/30 08:47:08 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: d623d617b0504dc8, StatelessResetToken: 0xd5aece5602c269e787b92ab7ead0c72f}
2025/04/30 08:47:08 client 	<- &wire.NewTokenFrame{Token: 0x0124f8c93766bcbd6522a59602e84cfce1f98e2dde8aa9bbf6b19a7759dad0b8d50affb82c34a80faeea385c07f72c18298e27da6dd5}
2025/04/30 08:47:08 client 	Queuing ACK because there's a new missing packet to report.
2025/04/30 08:47:08 client -> Sending packet 2 (39 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: ECT(0))
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 4, LowestAcked: 2, AckRanges: {{Largest: 4, Smallest: 4}, {Largest: 2, Smallest: 2}}, DelayTime: 56.175µs, ECT0: 0, ECT1: 2, CE: 0}
2025/04/30 08:47:08 client 	-> &wire.RetireConnectionIDFrame{SequenceNumber: 0}
2025/04/30 08:47:08 client <- Reading packet 5 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 136µs}
2025/04/30 08:47:08 client 	newly acked packets (1): [0]
2025/04/30 08:47:08 client 	updated RTT: 40.381ms (σ: 17.345ms)
2025/04/30 08:47:08 client Disabling ECN. ECN-marked packet acknowledged, but no ECN counts on ACK frame.
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1207, Offset + Data length: 1207}
2025/04/30 08:47:08 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:47:08 client <- Reading packet 6 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1207, Data length: 1210, Offset + Data length: 2417}
2025/04/30 08:47:08 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 08:47:08 client -> Sending packet 3 (37 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: Not-ECT)
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 6, LowestAcked: 2, AckRanges: {{Largest: 6, Smallest: 4}, {Largest: 2, Smallest: 2}}, DelayTime: 41.037µs, ECT0: 0, ECT1: 4, CE: 0}
2025/04/30 08:47:08 client <- Reading packet 7 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 7, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2417, Data length: 1210, Offset + Data length: 3627}
2025/04/30 08:47:08 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:47:08 client <- Reading packet 8 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 8, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3627, Data length: 1210, Offset + Data length: 4837}
2025/04/30 08:47:08 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 08:47:08 client -> Sending packet 4 (37 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: Not-ECT)
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 8, LowestAcked: 2, AckRanges: {{Largest: 8, Smallest: 4}, {Largest: 2, Smallest: 2}}, DelayTime: 46.127µs, ECT0: 0, ECT1: 6, CE: 0}
2025/04/30 08:47:08 client <- Reading packet 9 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 9, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4837, Data length: 1210, Offset + Data length: 6047}
2025/04/30 08:47:08 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:47:08 client <- Reading packet 10 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 10, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6047, Data length: 1210, Offset + Data length: 7257}
2025/04/30 08:47:08 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 08:47:08 client -> Sending packet 5 (37 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: Not-ECT)
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 10, LowestAcked: 2, AckRanges: {{Largest: 10, Smallest: 4}, {Largest: 2, Smallest: 2}}, DelayTime: 40.687µs, ECT0: 0, ECT1: 8, CE: 0}
2025/04/30 08:47:08 client <- Reading packet 11 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7257, Data length: 1210, Offset + Data length: 8467}
2025/04/30 08:47:08 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:47:08 client <- Reading packet 12 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 12, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 8467, Data length: 1210, Offset + Data length: 9677}
2025/04/30 08:47:08 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 08:47:08 client -> Sending packet 6 (37 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: Not-ECT)
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 12, LowestAcked: 2, AckRanges: {{Largest: 12, Smallest: 4}, {Largest: 2, Smallest: 2}}, DelayTime: 44.964µs, ECT0: 0, ECT1: 10, CE: 0}
2025/04/30 08:47:08 client <- Reading packet 13 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 13, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 9677, Data length: 563, Offset + Data length: 10240}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 0, Data length: 643, Offset + Data length: 643}
2025/04/30 08:47:08 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:47:08 client <- Reading packet 14 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 14, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 643, Data length: 1210, Offset + Data length: 1853}
2025/04/30 08:47:08 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 08:47:08 client -> Sending packet 7 (37 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: Not-ECT)
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 14, LowestAcked: 2, AckRanges: {{Largest: 14, Smallest: 4}, {Largest: 2, Smallest: 2}}, DelayTime: 38.643µs, ECT0: 0, ECT1: 12, CE: 0}
2025/04/30 08:47:08 client <- Reading packet 15 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 15, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 1853, Data length: 1210, Offset + Data length: 3063}
2025/04/30 08:47:08 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:47:08 client <- Reading packet 16 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 16, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 3063, Data length: 1210, Offset + Data length: 4273}
2025/04/30 08:47:08 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 08:47:08 client -> Sending packet 8 (37 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: Not-ECT)
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.AckFrame{LargestAcked: 16, LowestAcked: 2, AckRanges: {{Largest: 16, Smallest: 4}, {Largest: 2, Smallest: 2}}, DelayTime: 34.835µs, ECT0: 0, ECT1: 14, CE: 0}
2025/04/30 08:47:08 client <- Reading packet 17 (871 bytes) for connection (empty), 1-RTT
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: (empty), PacketNumber: 17, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:47:08 client 	<- &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 4273, Data length: 847, Offset + Data length: 5120}
2025/04/30 08:47:08 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:47:08 client Closing connection with error: Application error 0x0 (local)
2025/04/30 08:47:08 client -> Sending packet 9 (30 bytes) for connection 9bb867aa237018283de4b78159102158dbd6, 1-RTT (ECN: Not-ECT)
2025/04/30 08:47:08 client 	Short Header{DestConnectionID: 1d2efae8c96fb9f3, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:47:08 client 	-> &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""}
2025/04/30 08:47:08 Replacing connection for connection IDs [(empty)] with a closed connection.
2025/04/30 08:47:08 client Connection 9bb867aa237018283de4b78159102158dbd6 closed.