2025/04/30 11:20:20 Requesting https://server6:443/xivzwcunge. 2025/04/30 11:20:20 Requesting https://server6:443/qpojzjmmry. 2025/04/30 11:20:20 Increased receive buffer size to 14336 kiB 2025/04/30 11:20:20 Increased send buffer size to 14336 kiB 2025/04/30 11:20:20 Setting DF for IPv4 and IPv6. 2025/04/30 11:20:20 Activating reading of ECN bits for IPv4 and IPv6. 2025/04/30 11:20:20 Activating reading of packet info for IPv4 and IPv6. 2025/04/30 11:20:20 Created qlog file: /logs/qlog/ce904ea882800e123d830d23.sqlog 2025/04/30 11:20:20 client Starting new connection to server6 ([::]:60628 -> [fd00:cafe:cafe:100::100]:443), source connection ID (empty), destination connection ID ce904ea882800e123d830d23, version v1 2025/04/30 11:20:20 Adding connection ID (empty). 2025/04/30 11:20:20 client Not doing 0-RTT. Has sealer: false, has params: false 2025/04/30 11:20:20 client -> Sending packet 0 (1280 bytes) for connection ce904ea882800e123d830d23, Initial 2025/04/30 11:20:20 client Long Header{Type: Initial, DestConnectionID: ce904ea882800e123d830d23, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 1258, Version: v1} 2025/04/30 11:20:20 client -> &wire.CryptoFrame{Offset: 0, Data length: 263, Offset + Data length: 263} 2025/04/30 11:20:20 client Parsed a coalesced packet. Part 1: 135 bytes. Remaining: 1065 bytes. 2025/04/30 11:20:20 client <- Reading packet 0 (135 bytes) for connection (empty), Initial 2025/04/30 11:20:20 client Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: 13116051b241ab0a, Token: (empty), PacketNumber: 0, PacketNumberLen: 1, Length: 117, Version: v1} 2025/04/30 11:20:20 client Received first packet. Switching destination connection ID to: 13116051b241ab0a 2025/04/30 11:20:20 client <- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 2ms} 2025/04/30 11:20:20 client newly acked packets (1): [0] 2025/04/30 11:20:20 client updated RTT: 42.232136ms (σ: 21.116068ms) 2025/04/30 11:20:20 client <- &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90} 2025/04/30 11:20:20 client Installed Handshake Write keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:20:20 client Installed Handshake Read keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:20:20 client Parsed a coalesced packet. Part 2: 1065 bytes. Remaining: 0 bytes. 2025/04/30 11:20:20 client <- Reading packet 0 (1065 bytes) for connection (empty), Handshake 2025/04/30 11:20:20 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 13116051b241ab0a, PacketNumber: 0, PacketNumberLen: 1, Length: 1048, Version: v1} 2025/04/30 11:20:20 client <- &wire.CryptoFrame{Offset: 0, Data length: 734, Offset + Data length: 734} 2025/04/30 11:20:20 client Installed 1-RTT Write keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:20:20 client Installed 1-RTT Read keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:20:20 client Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: ce904ea882800e123d830d23, InitialSourceConnectionID: 13116051b241ab0a, InitialMaxStreamDataBidiLocal: 16380, InitialMaxStreamDataBidiRemote: 1474200, InitialMaxStreamDataUni: 16380, InitialMaxData: 1638000, MaxBidiStreamNum: 100, MaxUniStreamNum: 3, MaxIdleTimeout: 30s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 8, StatelessResetToken: 0x3347faf5cceb2ba01e0b3d5ae99c8483} 2025/04/30 11:20:20 client -> Sending coalesced packet (2 parts, 1280 bytes) for connection ce904ea882800e123d830d23 2025/04/30 11:20:20 client Long Header{Type: Initial, DestConnectionID: 13116051b241ab0a, SrcConnectionID: (empty), Token: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 1172, Version: v1} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:20:20 client Long Header{Type: Handshake, DestConnectionID: 13116051b241ab0a, SrcConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 73, Version: v1} 2025/04/30 11:20:20 client -> &wire.CryptoFrame{Offset: 0, Data length: 52, Offset + Data length: 52} 2025/04/30 11:20:20 client Dropping Initial keys. 2025/04/30 11:20:20 client -> Sending packet 1 (40 bytes) for connection ce904ea882800e123d830d23, Handshake 2025/04/30 11:20:20 client Long Header{Type: Handshake, DestConnectionID: 13116051b241ab0a, SrcConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:20:20 client -> Sending packet 0 (46 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: ECT(0)) 2025/04/30 11:20:20 client Short Header{DestConnectionID: 13116051b241ab0a, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17} 2025/04/30 11:20:20 client -> Sending packet 1 (46 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: ECT(0)) 2025/04/30 11:20:20 client Short Header{DestConnectionID: 13116051b241ab0a, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17} 2025/04/30 11:20:20 client Parsed a coalesced packet. Part 1: 38 bytes. Remaining: 568 bytes. 2025/04/30 11:20:20 client <- Reading packet 1 (38 bytes) for connection (empty), Handshake 2025/04/30 11:20:20 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 13116051b241ab0a, PacketNumber: 1, PacketNumberLen: 1, Length: 22, Version: v1} 2025/04/30 11:20:20 client <- &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:20:20 client Peer doesn't await address validation any longer. 2025/04/30 11:20:20 client newly acked packets (1): [0] 2025/04/30 11:20:20 client Canceling loss detection timer. 2025/04/30 11:20:20 client <- Reading packet 0 (568 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.CryptoFrame{Offset: 0, Data length: 546, Offset + Data length: 546} 2025/04/30 11:20:20 client Queueing ACK because the first packet should be acknowledged. 2025/04/30 11:20:20 client -> Sending packet 2 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: ECT(0)) 2025/04/30 11:20:20 client Short Header{DestConnectionID: 13116051b241ab0a, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 113.533µs} 2025/04/30 11:20:20 client <- Reading packet 1 (148 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 2ms} 2025/04/30 11:20:20 client newly acked packets (2): [0 1] 2025/04/30 11:20:20 client updated RTT: 41.324ms (σ: 17.651ms) 2025/04/30 11:20:20 client Disabling ECN. ECN-marked packet acknowledged, but no ECN counts on ACK frame. 2025/04/30 11:20:20 client Dropping Handshake keys. 2025/04/30 11:20:20 client <- &wire.HandshakeDoneFrame{} 2025/04/30 11:20:20 client <- &wire.NewTokenFrame{Token: 0xb75548b4a749d81fcfb8137c1c3f9df819f0704659c7ef8971461ad410d7eb77a504201194} 2025/04/30 11:20:20 client <- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: ea52f577cb96b1f8, StatelessResetToken: 0x1a6af5551dc7122314d410d1bf731a25} 2025/04/30 11:20:20 client <- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: e7abb977a85ee16d, StatelessResetToken: 0xf579fa64536b9f29c3269d7115182fab} 2025/04/30 11:20:20 client <- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: e738049e8704d129, StatelessResetToken: 0x6178ddf9772b4ace3284f31d94d4eb01} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client -> Sending packet 3 (34 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 79.609µs} 2025/04/30 11:20:20 client -> &wire.RetireConnectionIDFrame{SequenceNumber: 0} 2025/04/30 11:20:20 client <- Reading packet 2 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1210, Offset + Data length: 1210} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client <- Reading packet 3 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 3, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1210, Data length: 1208, Offset + Data length: 2418} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 4 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 47.6µs} 2025/04/30 11:20:20 client <- Reading packet 4 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2418, Data length: 1208, Offset + Data length: 3626} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client <- Reading packet 5 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3626, Data length: 1208, Offset + Data length: 4834} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 5 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 57.979µs} 2025/04/30 11:20:20 client <- Reading packet 6 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4834, Data length: 1208, Offset + Data length: 6042} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client <- Reading packet 7 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 7, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6042, Data length: 1208, Offset + Data length: 7250} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 6 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 7, LowestAcked: 0, DelayTime: 58.66µs} 2025/04/30 11:20:20 client <- Reading packet 8 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 8, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7250, Data length: 1208, Offset + Data length: 8458} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client <- Reading packet 9 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 9, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 8458, Data length: 1208, Offset + Data length: 9666} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 7 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 9, LowestAcked: 0, DelayTime: 47.559µs} 2025/04/30 11:20:20 client <- Reading packet 10 (598 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 10, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 9666, Data length: 574, Offset + Data length: 10240} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client <- Reading packet 11 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 11, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 0, Data length: 1210, Offset + Data length: 1210} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 8 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 11, LowestAcked: 0, DelayTime: 45.715µs} 2025/04/30 11:20:20 client <- Reading packet 12 (1118 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 12, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 1210, Data length: 1094, Offset + Data length: 2304} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client <- Reading packet 13 (1136 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 13, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 2304, Data length: 1112, Offset + Data length: 3416} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 9 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 13, LowestAcked: 0, DelayTime: 72.246µs} 2025/04/30 11:20:20 client <- Reading packet 14 (51 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 14, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.AckFrame{LargestAcked: 3, LowestAcked: 2, DelayTime: 0s} 2025/04/30 11:20:20 client newly acked packets (1): [3] 2025/04/30 11:20:20 client updated RTT: 40.066ms (σ: 15.753ms) 2025/04/30 11:20:20 client Canceling loss detection timer. 2025/04/30 11:20:20 client <- &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: 7a3d9921814fcc99, StatelessResetToken: 0xd4ebb1a6d703922b2ad650ebad0e5d36} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client Ignoring all packets below 2. 2025/04/30 11:20:20 client <- Reading packet 15 (245 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 15, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 3416, Data length: 221, Offset + Data length: 3637} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 10 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 10, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 15, LowestAcked: 2, DelayTime: 51.176µs} 2025/04/30 11:20:20 client <- Reading packet 16 (1232 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 16, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 4, Fin: false, Offset: 3637, Data length: 1208, Offset + Data length: 4845} 2025/04/30 11:20:20 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:20:20 client <- Reading packet 17 (299 bytes) for connection (empty), 1-RTT 2025/04/30 11:20:20 client Short Header{DestConnectionID: (empty), PacketNumber: 17, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:20:20 client <- &wire.StreamFrame{StreamID: 4, Fin: true, Offset: 4845, Data length: 275, Offset + Data length: 5120} 2025/04/30 11:20:20 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:20:20 client -> Sending packet 11 (32 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 11, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.AckFrame{LargestAcked: 17, LowestAcked: 2, DelayTime: 54.813µs} 2025/04/30 11:20:20 client Closing connection with error: Application error 0x0 (local) 2025/04/30 11:20:20 client -> Sending packet 12 (30 bytes) for connection ce904ea882800e123d830d23, 1-RTT (ECN: Not-ECT) 2025/04/30 11:20:20 client Short Header{DestConnectionID: ea52f577cb96b1f8, PacketNumber: 12, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:20:20 client -> &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""} 2025/04/30 11:20:20 Replacing connection for connection IDs [(empty)] with a closed connection. 2025/04/30 11:20:20 client Connection ce904ea882800e123d830d23 closed.