2025/04/30 10:37:58 Requesting https://server6:443/hjzjjtcejz.
2025/04/30 10:37:58 Requesting https://server6:443/rlakwuminw.
2025/04/30 10:37:58 Increased receive buffer size to 14336 kiB
2025/04/30 10:37:58 Increased send buffer size to 14336 kiB
2025/04/30 10:37:58 Setting DF for IPv4 and IPv6.
2025/04/30 10:37:58 Activating reading of ECN bits for IPv4 and IPv6.
2025/04/30 10:37:58 Activating reading of packet info for IPv4 and IPv6.
2025/04/30 10:37:58 Created qlog file: /logs/qlog/40c1b887a692e86963d89c6f1438a639b236.sqlog
2025/04/30 10:37:58 client Starting new connection to server6 ([::]:60621 -> [fd00:cafe:cafe:100::100]:443), source connection ID (empty), destination connection ID 40c1b887a692e86963d89c6f1438a639b236, version v1
2025/04/30 10:37:58 Adding connection ID (empty).
2025/04/30 10:37:58 client Not doing 0-RTT. Has sealer: false, has params: false
2025/04/30 10:37:58 client -> Sending packet 0 (1280 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, Initial
2025/04/30 10:37:58 client 	Long Header{Type: Initial, DestConnectionID: 40c1b887a692e86963d89c6f1438a639b236, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 1252, Version: v1}
2025/04/30 10:37:58 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 266, Offset + Data length: 266}
2025/04/30 10:37:58 client Parsed a coalesced packet. Part 1: 146 bytes. Remaining: 1054 bytes.
2025/04/30 10:37:58 client <- Reading packet 0 (146 bytes) for connection (empty), Initial
2025/04/30 10:37:58 client 	Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, Token: (empty), PacketNumber: 0, PacketNumberLen: 1, Length: 116, Version: v1}
2025/04/30 10:37:58 client Received first packet. Switching destination connection ID to: d4f59da8da5b07ba05661845b11d9044a9aa0dcf
2025/04/30 10:37:58 client 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 352µs}
2025/04/30 10:37:58 client 	newly acked packets (1): [0]
2025/04/30 10:37:58 client 	updated RTT: 40.431494ms (σ: 20.215747ms)
2025/04/30 10:37:58 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90}
2025/04/30 10:37:58 client Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 10:37:58 client Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 10:37:58 client Parsed a coalesced packet. Part 2: 756 bytes. Remaining: 298 bytes.
2025/04/30 10:37:58 client <- Reading packet 1 (756 bytes) for connection (empty), Handshake
2025/04/30 10:37:58 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, PacketNumber: 1, PacketNumberLen: 1, Length: 727, Version: v1}
2025/04/30 10:37:58 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 706, Offset + Data length: 706}
2025/04/30 10:37:58 client Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 10:37:58 client Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 10:37:58 client Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: 40c1b887a692e86963d89c6f1438a639b236, InitialSourceConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, InitialMaxStreamDataBidiLocal: 1000000, InitialMaxStreamDataBidiRemote: 1000000, InitialMaxStreamDataUni: 1000000, InitialMaxData: 10000000, MaxBidiStreamNum: 100, MaxUniStreamNum: 100, MaxIdleTimeout: 30s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 8}
2025/04/30 10:37:58 client Dropping %!s(logging.PacketType=5) packet (298 bytes) for which we couldn't unpack the header. Error: not a QUIC packet
2025/04/30 10:37:58 client -> Sending coalesced packet (2 parts, 1280 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236
2025/04/30 10:37:58 client 	Long Header{Type: Initial, DestConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, SrcConnectionID: (empty), Token: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 1164, Version: v1}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s}
2025/04/30 10:37:58 client 	Long Header{Type: Handshake, DestConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, SrcConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 57, Version: v1}
2025/04/30 10:37:58 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36}
2025/04/30 10:37:58 client Dropping Initial keys.
2025/04/30 10:37:58 client -> Sending packet 1 (52 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, Handshake
2025/04/30 10:37:58 client 	Long Header{Type: Handshake, DestConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, SrcConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 23, Version: v1}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 1, LowestAcked: 1, DelayTime: 0s}
2025/04/30 10:37:58 client -> Sending packet 0 (58 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: ECT(0))
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 10:37:58 client -> Sending packet 1 (58 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: ECT(0))
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: d4f59da8da5b07ba05661845b11d9044a9aa0dcf, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 10:37:58 client <- Reading packet 2 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 80µs}
2025/04/30 10:37:58 client Peer doesn't await address validation any longer.
2025/04/30 10:37:58 client 	newly acked packets (2): [0 1]
2025/04/30 10:37:58 client 	updated RTT: 39.494ms (σ: 17.035ms)
2025/04/30 10:37:58 client Disabling ECN. ECN-marked packet acknowledged, but no ECN counts on ACK frame.
2025/04/30 10:37:58 client Canceling loss detection timer.
2025/04/30 10:37:58 client Dropping Handshake keys.
2025/04/30 10:37:58 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, StatelessResetToken: 0xf822561dd704588282723b950fe7eaed}
2025/04/30 10:37:58 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: c2976a311e55684c0be74e8a0a08e84a9bec81ed, StatelessResetToken: 0xc4e368d26cec499f981e2d8a2f0f3714}
2025/04/30 10:37:58 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: c4951293ccb24aed094ebed5ab08eb0d550f1253, StatelessResetToken: 0x340de594be0578d21de7b24d978fa2f7}
2025/04/30 10:37:58 client 	<- &wire.HandshakeDoneFrame{}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1201, Offset + Data length: 1201}
2025/04/30 10:37:58 client 	Queueing ACK because the first packet should be acknowledged.
2025/04/30 10:37:58 client -> Sending packet 2 (46 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 2, LowestAcked: 2, DelayTime: 192.148µs}
2025/04/30 10:37:58 client 	-> &wire.RetireConnectionIDFrame{SequenceNumber: 0}
2025/04/30 10:37:58 client <- Reading packet 3 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 3, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 0, Data length: 1327, Offset + Data length: 1327}
2025/04/30 10:37:58 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 10:37:58 client <- Reading packet 4 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1201, Data length: 1326, Offset + Data length: 2527}
2025/04/30 10:37:58 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 10:37:58 client -> Sending packet 3 (44 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 4, LowestAcked: 2, DelayTime: 38.772µs}
2025/04/30 10:37:58 client <- Reading packet 5 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 1327, Data length: 1326, Offset + Data length: 2653}
2025/04/30 10:37:58 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 10:37:58 client <- Reading packet 6 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2527, Data length: 1326, Offset + Data length: 3853}
2025/04/30 10:37:58 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 10:37:58 client -> Sending packet 4 (44 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 6, LowestAcked: 2, DelayTime: 45.735µs}
2025/04/30 10:37:58 client <- Reading packet 7 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 7, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 2653, Data length: 1326, Offset + Data length: 3979}
2025/04/30 10:37:58 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 10:37:58 client <- Reading packet 8 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 8, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3853, Data length: 1326, Offset + Data length: 5179}
2025/04/30 10:37:58 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 10:37:58 client -> Sending packet 5 (44 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 8, LowestAcked: 2, DelayTime: 46.647µs}
2025/04/30 10:37:58 client <- Reading packet 9 (1165 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 9, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 3979, Data length: 1141, Offset + Data length: 5120}
2025/04/30 10:37:58 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 10:37:58 client <- Reading packet 10 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 10, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 5179, Data length: 1326, Offset + Data length: 6505}
2025/04/30 10:37:58 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 10:37:58 client -> Sending packet 6 (44 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 10, LowestAcked: 2, DelayTime: 47.308µs}
2025/04/30 10:37:58 client <- Reading packet 11 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 11, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6505, Data length: 1326, Offset + Data length: 7831}
2025/04/30 10:37:58 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 10:37:58 client <- Reading packet 12 (185 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 12, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7831, Data length: 161, Offset + Data length: 7992}
2025/04/30 10:37:58 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 10:37:58 client -> Sending packet 7 (44 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 12, LowestAcked: 2, DelayTime: 41.497µs}
2025/04/30 10:37:58 client <- Reading packet 13 (1350 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 13, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.AckFrame{LargestAcked: 2, LowestAcked: 2, DelayTime: 56µs}
2025/04/30 10:37:58 client 	newly acked packets (1): [2]
2025/04/30 10:37:58 client 	updated RTT: 38.533ms (σ: 14.697ms)
2025/04/30 10:37:58 client Canceling loss detection timer.
2025/04/30 10:37:58 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 1, ConnectionID: 6cb653286aa8b7bde90c45e01bbc8b796b99516f, StatelessResetToken: 0xe54dfe3935bfff37c6d54a6e8afc3ba9}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7992, Data length: 1281, Offset + Data length: 9273}
2025/04/30 10:37:58 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 10:37:58 client 	Ignoring all packets below 3.
2025/04/30 10:37:58 client <- Reading packet 14 (991 bytes) for connection (empty), 1-RTT
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: (empty), PacketNumber: 14, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 10:37:58 client 	<- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 9273, Data length: 967, Offset + Data length: 10240}
2025/04/30 10:37:58 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 10:37:58 client -> Sending packet 8 (44 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.AckFrame{LargestAcked: 14, LowestAcked: 3, DelayTime: 38.623µs}
2025/04/30 10:37:58 client Closing connection with error: Application error 0x0 (local)
2025/04/30 10:37:58 client -> Sending packet 9 (42 bytes) for connection 40c1b887a692e86963d89c6f1438a639b236, 1-RTT (ECN: Not-ECT)
2025/04/30 10:37:58 client 	Short Header{DestConnectionID: 74228381d2ada9d6636de4b3f27c85e44e256656, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 10:37:58 client 	-> &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""}
2025/04/30 10:37:58 Replacing connection for connection IDs [(empty)] with a closed connection.
2025/04/30 10:37:58 client Connection 40c1b887a692e86963d89c6f1438a639b236 closed.