2025/04/30 09:39:42 Requesting https://server6:443/bgrgdlzhrp.
2025/04/30 09:39:42 Requesting https://server6:443/tiimpftoxd.
2025/04/30 09:39:42 Increased receive buffer size to 14336 kiB
2025/04/30 09:39:42 Increased send buffer size to 14336 kiB
2025/04/30 09:39:42 Setting DF for IPv4 and IPv6.
2025/04/30 09:39:42 Activating reading of ECN bits for IPv4 and IPv6.
2025/04/30 09:39:42 Activating reading of packet info for IPv4 and IPv6.
2025/04/30 09:39:42 Created qlog file: /logs/qlog/51856e1b4e553718bfa5e2d68f58.sqlog
2025/04/30 09:39:42 client Starting new connection to server6 ([::]:53301 -> [fd00:cafe:cafe:100::100]:443), source connection ID (empty), destination connection ID 51856e1b4e553718bfa5e2d68f58, version v1
2025/04/30 09:39:42 Adding connection ID (empty).
2025/04/30 09:39:42 client Not doing 0-RTT. Has sealer: false, has params: false
2025/04/30 09:39:42 client -> Sending packet 0 (1280 bytes) for connection 51856e1b4e553718bfa5e2d68f58, Initial
2025/04/30 09:39:42 client 	Long Header{Type: Initial, DestConnectionID: 51856e1b4e553718bfa5e2d68f58, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 1256, Version: v1}
2025/04/30 09:39:42 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 264, Offset + Data length: 264}
2025/04/30 09:39:42 client <- Reading packet 11706993 (1232 bytes) for connection (empty), Initial
2025/04/30 09:39:42 client 	Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: 400000570b0475bd, Token: (empty), PacketNumber: 11706993, PacketNumberLen: 4, Length: 1214, Version: v1}
2025/04/30 09:39:42 client Received first packet. Switching destination connection ID to: 400000570b0475bd
2025/04/30 09:39:42 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90}
2025/04/30 09:39:42 client Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:39:42 client Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:39:42 client 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 848µs}
2025/04/30 09:39:42 client 	newly acked packets (1): [0]
2025/04/30 09:39:42 client 	updated RTT: 40.482575ms (σ: 20.241287ms)
2025/04/30 09:39:42 client -> Sending packet 1 (1280 bytes) for connection 51856e1b4e553718bfa5e2d68f58, Initial
2025/04/30 09:39:42 client 	Long Header{Type: Initial, DestConnectionID: 400000570b0475bd, SrcConnectionID: (empty), Token: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 1262, Version: v1}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11706993, LowestAcked: 11706993, DelayTime: 0s}
2025/04/30 09:39:42 client <- Reading packet 11706993 (760 bytes) for connection (empty), Handshake
2025/04/30 09:39:42 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 400000570b0475bd, PacketNumber: 11706993, PacketNumberLen: 4, Length: 743, Version: v1}
2025/04/30 09:39:42 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 719, Offset + Data length: 719}
2025/04/30 09:39:42 client Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:39:42 client Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:39:42 client Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: 51856e1b4e553718bfa5e2d68f58, InitialSourceConnectionID: 400000570b0475bd, InitialMaxStreamDataBidiLocal: 262144, InitialMaxStreamDataBidiRemote: 262144, InitialMaxStreamDataUni: 262144, InitialMaxData: 2621440, MaxBidiStreamNum: 100, MaxUniStreamNum: 100, MaxIdleTimeout: 1m0s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 2, StatelessResetToken: 0x0b68eab5f1043cf53d2f15aeb54ee1ad, MaxDatagramFrameSize: 65535}
2025/04/30 09:39:42 client -> Sending packet 0 (82 bytes) for connection 51856e1b4e553718bfa5e2d68f58, Handshake
2025/04/30 09:39:42 client 	Long Header{Type: Handshake, DestConnectionID: 400000570b0475bd, SrcConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 65, Version: v1}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11706993, LowestAcked: 11706993, DelayTime: 0s}
2025/04/30 09:39:42 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36}
2025/04/30 09:39:42 client Dropping Initial keys.
2025/04/30 09:39:42 client -> Sending packet 0 (46 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: ECT(0))
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 400000570b0475bd, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 09:39:42 client -> Sending packet 1 (46 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: ECT(0))
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 400000570b0475bd, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 09:39:42 client <- Reading packet 11706994 (38 bytes) for connection (empty), Handshake
2025/04/30 09:39:42 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 400000570b0475bd, PacketNumber: 11706994, PacketNumberLen: 1, Length: 22, Version: v1}
2025/04/30 09:39:42 client 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 168µs}
2025/04/30 09:39:42 client Peer doesn't await address validation any longer.
2025/04/30 09:39:42 client 	newly acked packets (1): [0]
2025/04/30 09:39:42 client 	updated RTT: 39.32ms (σ: 17.503ms)
2025/04/30 09:39:42 client Canceling loss detection timer.
2025/04/30 09:39:42 client <- Reading packet 11706993 (112 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11706993, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.HandshakeDoneFrame{}
2025/04/30 09:39:42 client Dropping Handshake keys.
2025/04/30 09:39:42 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 4000005b1984fb79, StatelessResetToken: 0x4c8de560e1319a09c2b2761a92e014cd}
2025/04/30 09:39:42 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 400000540763a150, StatelessResetToken: 0x764d6eefa175db032fbb6c7b0dbacffd}
2025/04/30 09:39:42 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: 40000043d849c095, StatelessResetToken: 0xee2325e32ce2033e7f402ac75fb1a76f}
2025/04/30 09:39:42 client 	Queueing ACK because the first packet should be acknowledged.
2025/04/30 09:39:42 client -> Sending packet 2 (37 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: ECT(0))
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11706993, LowestAcked: 11706993, DelayTime: 62.116µs}
2025/04/30 09:39:42 client 	-> &wire.RetireConnectionIDFrame{SequenceNumber: 0}
2025/04/30 09:39:42 client <- Reading packet 11706994 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11706994, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 504µs}
2025/04/30 09:39:42 client 	newly acked packets (2): [0 1]
2025/04/30 09:39:42 client 	updated RTT: 38.405ms (σ: 14.956ms)
2025/04/30 09:39:42 client Disabling ECN. ECN-marked packet acknowledged, but no ECN counts on ACK frame.
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1204, Offset + Data length: 1204}
2025/04/30 09:39:42 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:39:42 client <- Reading packet 11706995 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11706995, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1204, Data length: 1207, Offset + Data length: 2411}
2025/04/30 09:39:42 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:39:42 client -> Sending packet 3 (35 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11706995, LowestAcked: 11706993, DelayTime: 50.735µs}
2025/04/30 09:39:42 client <- Reading packet 11706996 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11706996, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2411, Data length: 1207, Offset + Data length: 3618}
2025/04/30 09:39:42 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:39:42 client <- Reading packet 11706997 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11706997, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3618, Data length: 1207, Offset + Data length: 4825}
2025/04/30 09:39:42 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:39:42 client -> Sending packet 4 (35 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11706997, LowestAcked: 11706993, DelayTime: 42.409µs}
2025/04/30 09:39:42 client <- Reading packet 11706998 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11706998, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4825, Data length: 1207, Offset + Data length: 6032}
2025/04/30 09:39:42 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:39:42 client <- Reading packet 11706999 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11706999, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6032, Data length: 1207, Offset + Data length: 7239}
2025/04/30 09:39:42 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:39:42 client -> Sending packet 5 (35 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11706999, LowestAcked: 11706993, DelayTime: 39.704µs}
2025/04/30 09:39:42 client <- Reading packet 11707000 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707000, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7239, Data length: 1207, Offset + Data length: 8446}
2025/04/30 09:39:42 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:39:42 client <- Reading packet 11707001 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707001, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 8446, Data length: 1207, Offset + Data length: 9653}
2025/04/30 09:39:42 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:39:42 client -> Sending packet 6 (35 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11707001, LowestAcked: 11706993, DelayTime: 35.096µs}
2025/04/30 09:39:42 client <- Reading packet 11707002 (624 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707002, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 9653, Data length: 587, Offset + Data length: 10240}
2025/04/30 09:39:42 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:39:42 client <- Reading packet 11707003 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707003, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 0, Data length: 1209, Offset + Data length: 1209}
2025/04/30 09:39:42 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:39:42 client -> Sending packet 7 (35 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11707003, LowestAcked: 11706993, DelayTime: 45.425µs}
2025/04/30 09:39:42 client <- Reading packet 11707004 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707004, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 1209, Data length: 1207, Offset + Data length: 2416}
2025/04/30 09:39:42 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:39:42 client <- Reading packet 11707005 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707005, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 2416, Data length: 1207, Offset + Data length: 3623}
2025/04/30 09:39:42 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:39:42 client -> Sending packet 8 (35 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11707005, LowestAcked: 11706993, DelayTime: 40.435µs}
2025/04/30 09:39:42 client <- Reading packet 11707006 (1232 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707006, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 3623, Data length: 1207, Offset + Data length: 4830}
2025/04/30 09:39:42 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:39:42 client <- Reading packet 11707007 (368 bytes) for connection (empty), 1-RTT
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11707007, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:39:42 client 	<- &wire.AckFrame{LargestAcked: 3, LowestAcked: 2, DelayTime: 56µs}
2025/04/30 09:39:42 client 	newly acked packets (1): [2]
2025/04/30 09:39:42 client Canceling loss detection timer.
2025/04/30 09:39:42 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: 40000051ccd7a333, StatelessResetToken: 0xecafc72319db6c87a00d5b148af498e6}
2025/04/30 09:39:42 client 	<- &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 4830, Data length: 290, Offset + Data length: 5120}
2025/04/30 09:39:42 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:39:42 client 	Ignoring all packets below 11706994.
2025/04/30 09:39:42 client -> Sending packet 9 (35 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.AckFrame{LargestAcked: 11707007, LowestAcked: 11706994, DelayTime: 82.805µs}
2025/04/30 09:39:42 client Closing connection with error: Application error 0x0 (local)
2025/04/30 09:39:42 client -> Sending packet 10 (30 bytes) for connection 51856e1b4e553718bfa5e2d68f58, 1-RTT (ECN: Not-ECT)
2025/04/30 09:39:42 client 	Short Header{DestConnectionID: 4000005b1984fb79, PacketNumber: 10, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:39:42 client 	-> &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""}
2025/04/30 09:39:42 Replacing connection for connection IDs [(empty)] with a closed connection.
2025/04/30 09:39:42 client Connection 51856e1b4e553718bfa5e2d68f58 closed.