2025/04/30 09:41:54 Requesting https://server6:443/sxsbyjwgau.
2025/04/30 09:41:54 Requesting https://server6:443/xyiwcoawbe.
2025/04/30 09:41:54 Increased receive buffer size to 14336 kiB
2025/04/30 09:41:54 Increased send buffer size to 14336 kiB
2025/04/30 09:41:54 Setting DF for IPv4 and IPv6.
2025/04/30 09:41:54 Activating reading of ECN bits for IPv4 and IPv6.
2025/04/30 09:41:54 Activating reading of packet info for IPv4 and IPv6.
2025/04/30 09:41:54 Created qlog file: /logs/qlog/fa7d772086fdaf717a5d.sqlog
2025/04/30 09:41:54 client Starting new connection to server6 ([::]:45546 -> [fd00:cafe:cafe:100::100]:443), source connection ID (empty), destination connection ID fa7d772086fdaf717a5d, version v1
2025/04/30 09:41:54 Adding connection ID (empty).
2025/04/30 09:41:54 client Not doing 0-RTT. Has sealer: false, has params: false
2025/04/30 09:41:54 client -> Sending packet 0 (1280 bytes) for connection fa7d772086fdaf717a5d, Initial
2025/04/30 09:41:54 client 	Long Header{Type: Initial, DestConnectionID: fa7d772086fdaf717a5d, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 1260, Version: v1}
2025/04/30 09:41:54 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 270, Offset + Data length: 270}
2025/04/30 09:41:54 client Parsed a coalesced packet. Part 1: 136 bytes. Remaining: 1096 bytes.
2025/04/30 09:41:54 client <- Reading packet 0 (136 bytes) for connection (empty), Initial
2025/04/30 09:41:54 client 	Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: be37e179078007176890, Token: (empty), PacketNumber: 0, PacketNumberLen: 1, Length: 116, Version: v1}
2025/04/30 09:41:54 client Received first packet. Switching destination connection ID to: be37e179078007176890
2025/04/30 09:41:54 client 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s}
2025/04/30 09:41:54 client 	newly acked packets (1): [0]
2025/04/30 09:41:54 client 	updated RTT: 42.895565ms (σ: 21.447782ms)
2025/04/30 09:41:54 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90}
2025/04/30 09:41:54 client Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:41:54 client Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:41:54 client Parsed a coalesced packet. Part 2: 767 bytes. Remaining: 329 bytes.
2025/04/30 09:41:54 client <- Reading packet 0 (767 bytes) for connection (empty), Handshake
2025/04/30 09:41:54 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: be37e179078007176890, PacketNumber: 0, PacketNumberLen: 1, Length: 748, Version: v1}
2025/04/30 09:41:54 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 727, Offset + Data length: 727}
2025/04/30 09:41:54 client Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:41:54 client Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:41:54 client Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: fa7d772086fdaf717a5d, InitialSourceConnectionID: be37e179078007176890, InitialMaxStreamDataBidiLocal: 1048576, InitialMaxStreamDataBidiRemote: 1048576, InitialMaxStreamDataUni: 1048576, InitialMaxData: 4611686018427387903, MaxBidiStreamNum: 16, MaxUniStreamNum: 16, MaxIdleTimeout: 30s, AckDelayExponent: 3, MaxAckDelay: 20ms, ActiveConnectionIDLimit: 8, MaxDatagramFrameSize: 0}
2025/04/30 09:41:54 client Dropping %!s(logging.PacketType=5) packet (329 bytes) for which we couldn't unpack the header. Error: not a QUIC packet
2025/04/30 09:41:54 client -> Sending coalesced packet (2 parts, 1280 bytes) for connection fa7d772086fdaf717a5d
2025/04/30 09:41:54 client 	Long Header{Type: Initial, DestConnectionID: be37e179078007176890, SrcConnectionID: (empty), Token: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 1184, Version: v1}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s, ECT0: 1, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client 	Long Header{Type: Handshake, DestConnectionID: be37e179078007176890, SrcConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 57, Version: v1}
2025/04/30 09:41:54 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36}
2025/04/30 09:41:54 client Dropping Initial keys.
2025/04/30 09:41:54 client -> Sending packet 1 (45 bytes) for connection fa7d772086fdaf717a5d, Handshake
2025/04/30 09:41:54 client 	Long Header{Type: Handshake, DestConnectionID: be37e179078007176890, SrcConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 26, Version: v1}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s, ECT0: 1, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client -> Sending packet 0 (48 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: be37e179078007176890, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 09:41:54 client -> Sending packet 1 (48 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: be37e179078007176890, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 09:41:54 client Parsed a coalesced packet. Part 1: 41 bytes. Remaining: 1291 bytes.
2025/04/30 09:41:54 client <- Reading packet 1 (41 bytes) for connection (empty), Handshake
2025/04/30 09:41:54 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: be37e179078007176890, PacketNumber: 1, PacketNumberLen: 1, Length: 22, Version: v1}
2025/04/30 09:41:54 client 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s}
2025/04/30 09:41:54 client Peer doesn't await address validation any longer.
2025/04/30 09:41:54 client 	newly acked packets (1): [0]
2025/04/30 09:41:54 client 	updated RTT: 41.684ms (σ: 18.506ms)
2025/04/30 09:41:54 client Canceling loss detection timer.
2025/04/30 09:41:54 client <- Reading packet 0 (1291 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.HandshakeDoneFrame{}
2025/04/30 09:41:54 client Dropping Handshake keys.
2025/04/30 09:41:54 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: b069fbd9a7b7ee9a55d9, StatelessResetToken: 0x4b6b7aa07eefea4bd59bb26cc46a7aa5}
2025/04/30 09:41:54 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 8036adfbf5ee7265bfe4, StatelessResetToken: 0x5bef170bf7e18ac5e062650ea7e129d0}
2025/04/30 09:41:54 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: 141243380abe3cfb4dd5, StatelessResetToken: 0x5674e9682ceb0ee99fe409a73626cf66}
2025/04/30 09:41:54 client 	Queueing ACK because the first packet should be acknowledged.
2025/04/30 09:41:54 client -> Sending packet 2 (39 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 154.35µs, ECT0: 1, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client 	-> &wire.RetireConnectionIDFrame{SequenceNumber: 0}
2025/04/30 09:41:54 client <- Reading packet 1 (1332 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.PingFrame{}
2025/04/30 09:41:54 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:41:54 client <- Reading packet 2 (26 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 0s, ECT0: 2, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client 	newly acked packets (2): [0 1]
2025/04/30 09:41:54 client 	updated RTT: 40.74ms (σ: 15.767ms)
2025/04/30 09:41:54 client ECN capability confirmed.
2025/04/30 09:41:54 client <- Reading packet 3 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 3, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1212, Offset + Data length: 1212}
2025/04/30 09:41:54 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:41:54 client -> Sending packet 3 (37 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 52.278µs, ECT0: 4, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client <- Reading packet 4 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1212, Data length: 1210, Offset + Data length: 2422}
2025/04/30 09:41:54 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:41:54 client <- Reading packet 5 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2422, Data length: 1210, Offset + Data length: 3632}
2025/04/30 09:41:54 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:41:54 client -> Sending packet 4 (37 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 50.135µs, ECT0: 6, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client <- Reading packet 6 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3632, Data length: 1210, Offset + Data length: 4842}
2025/04/30 09:41:54 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:41:54 client <- Reading packet 7 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 7, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4842, Data length: 1210, Offset + Data length: 6052}
2025/04/30 09:41:54 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:41:54 client -> Sending packet 5 (37 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 7, LowestAcked: 0, DelayTime: 49.032µs, ECT0: 8, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client <- Reading packet 8 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 8, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6052, Data length: 1210, Offset + Data length: 7262}
2025/04/30 09:41:54 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:41:54 client <- Reading packet 9 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 9, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7262, Data length: 1210, Offset + Data length: 8472}
2025/04/30 09:41:54 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:41:54 client -> Sending packet 6 (37 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 9, LowestAcked: 0, DelayTime: 53.931µs, ECT0: 9, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client <- Reading packet 10 (1073 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 10, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 8472, Data length: 1051, Offset + Data length: 9523}
2025/04/30 09:41:54 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:41:54 client <- Reading packet 11 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: 63aaed720070c05d45d8, StatelessResetToken: 0x52a15c89f835081ffdb0529ad6584504}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 9523, Data length: 717, Offset + Data length: 10240}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 0, Data length: 459, Offset + Data length: 459}
2025/04/30 09:41:54 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:41:54 client -> Sending packet 7 (37 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 11, LowestAcked: 0, DelayTime: 87.604µs, ECT0: 9, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client <- Reading packet 12 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 12, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 459, Data length: 1210, Offset + Data length: 1669}
2025/04/30 09:41:54 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:41:54 client <- Reading packet 13 (1372 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 13, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.PingFrame{}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 1669, Data length: 1349, Offset + Data length: 3018}
2025/04/30 09:41:54 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:41:54 client -> Sending packet 8 (37 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 13, LowestAcked: 0, DelayTime: 53.6µs, ECT0: 10, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client <- Reading packet 14 (1332 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 14, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 3018, Data length: 1310, Offset + Data length: 4328}
2025/04/30 09:41:54 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:41:54 client <- Reading packet 15 (1170 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 15, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 4328, Data length: 792, Offset + Data length: 5120}
2025/04/30 09:41:54 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 305, Offset + Data length: 305}
2025/04/30 09:41:54 client 	<- &wire.NewTokenFrame{Token: 0xad9a8b8d860100bf26d72cc1ea4e7206218db02eda71f5f7864425cf1a01eeae423394f88efad7ad1de531}
2025/04/30 09:41:54 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:41:54 client <- Reading packet 16 (26 bytes) for connection (empty), 1-RTT
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: (empty), PacketNumber: 16, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:41:54 client 	<- &wire.AckFrame{LargestAcked: 4, LowestAcked: 0, DelayTime: 0s, ECT0: 5, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client 	newly acked packets (1): [2]
2025/04/30 09:41:54 client Canceling loss detection timer.
2025/04/30 09:41:54 client 	Ignoring all packets below 1.
2025/04/30 09:41:54 client -> Sending packet 9 (37 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.AckFrame{LargestAcked: 16, LowestAcked: 1, DelayTime: 89.388µs, ECT0: 13, ECT1: 0, CE: 0}
2025/04/30 09:41:54 client Closing connection with error: Application error 0x0 (local)
2025/04/30 09:41:54 client -> Sending packet 10 (32 bytes) for connection fa7d772086fdaf717a5d, 1-RTT (ECN: ECT(0))
2025/04/30 09:41:54 client 	Short Header{DestConnectionID: b069fbd9a7b7ee9a55d9, PacketNumber: 10, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:41:54 client 	-> &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""}
2025/04/30 09:41:54 Replacing connection for connection IDs [(empty)] with a closed connection.
2025/04/30 09:41:54 client Connection fa7d772086fdaf717a5d closed.