2025/04/30 11:18:09 Requesting https://server4:443/vpyxaxvzmc. 2025/04/30 11:18:09 Increased receive buffer size to 14336 kiB 2025/04/30 11:18:09 Increased send buffer size to 14336 kiB 2025/04/30 11:18:09 Setting DF for IPv4 and IPv6. 2025/04/30 11:18:09 Activating reading of ECN bits for IPv4 and IPv6. 2025/04/30 11:18:09 Activating reading of packet info for IPv4 and IPv6. 2025/04/30 11:18:09 Created qlog file: /logs/qlog/74f52f2e1c681a98b1eb.sqlog 2025/04/30 11:18:09 client Starting new connection to server4 ([::]:58955 -> 193.167.100.100:443), source connection ID (empty), destination connection ID 74f52f2e1c681a98b1eb, version v1 2025/04/30 11:18:09 Adding connection ID (empty). 2025/04/30 11:18:09 client Not doing 0-RTT. Has sealer: false, has params: false 2025/04/30 11:18:09 client -> Sending packet 0 (1280 bytes) for connection 74f52f2e1c681a98b1eb, Initial 2025/04/30 11:18:09 client Long Header{Type: Initial, DestConnectionID: 74f52f2e1c681a98b1eb, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 1260, Version: v1} 2025/04/30 11:18:09 client -> &wire.CryptoFrame{Offset: 0, Data length: 265, Offset + Data length: 265} 2025/04/30 11:18:09 client Parsed a coalesced packet. Part 1: 135 bytes. Remaining: 1117 bytes. 2025/04/30 11:18:09 client <- Reading packet 0 (135 bytes) for connection (empty), Initial 2025/04/30 11:18:09 client Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, Token: (empty), PacketNumber: 0, PacketNumberLen: 1, Length: 117, Version: v1} 2025/04/30 11:18:09 client Received first packet. Switching destination connection ID to: a53b1c8af6cc27dc 2025/04/30 11:18:09 client <- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 1ms} 2025/04/30 11:18:09 client newly acked packets (1): [0] 2025/04/30 11:18:09 client updated RTT: 40.493673ms (σ: 20.246836ms) 2025/04/30 11:18:09 client <- &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90} 2025/04/30 11:18:09 client Installed Handshake Write keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:18:09 client Installed Handshake Read keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:18:09 client Parsed a coalesced packet. Part 2: 1117 bytes. Remaining: 0 bytes. 2025/04/30 11:18:09 client <- Reading packet 0 (1117 bytes) for connection (empty), Handshake 2025/04/30 11:18:09 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 0, PacketNumberLen: 1, Length: 1100, Version: v1} 2025/04/30 11:18:09 client <- &wire.CryptoFrame{Offset: 0, Data length: 1079, Offset + Data length: 1079} 2025/04/30 11:18:09 client Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: 74f52f2e1c681a98b1eb, InitialSourceConnectionID: a53b1c8af6cc27dc, InitialMaxStreamDataBidiLocal: 16380, InitialMaxStreamDataBidiRemote: 1474200, InitialMaxStreamDataUni: 16380, InitialMaxData: 1638000, MaxBidiStreamNum: 100, MaxUniStreamNum: 3, MaxIdleTimeout: 30s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 8, StatelessResetToken: 0xf39aba1916e3097bf23b1e62b8586ac0} 2025/04/30 11:18:09 client -> Sending packet 1 (1280 bytes) for connection 74f52f2e1c681a98b1eb, Initial 2025/04/30 11:18:09 client Long Header{Type: Initial, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), Token: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 1262, Version: v1} 2025/04/30 11:18:09 client -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:09 client -> Sending packet 0 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:09 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:09 client -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:09 client Dropping Initial keys. 2025/04/30 11:18:09 client <- Reading packet 1 (1252 bytes) for connection (empty), Handshake 2025/04/30 11:18:09 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 1, PacketNumberLen: 1, Length: 1235, Version: v1} 2025/04/30 11:18:09 client <- &wire.CryptoFrame{Offset: 1079, Data length: 1213, Offset + Data length: 2292} 2025/04/30 11:18:09 client -> Sending packet 1 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:09 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:09 client -> &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:09 client <- Reading packet 2 (1252 bytes) for connection (empty), Handshake 2025/04/30 11:18:09 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 2, PacketNumberLen: 1, Length: 1235, Version: v1} 2025/04/30 11:18:09 client <- &wire.CryptoFrame{Offset: 2292, Data length: 1213, Offset + Data length: 3505} 2025/04/30 11:18:09 client -> Sending packet 2 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:09 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:09 client -> &wire.AckFrame{LargestAcked: 2, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:09 client -> Sending packet 3 (37 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:09 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 3, PacketNumberLen: 2, Length: 20, Version: v1} 2025/04/30 11:18:09 client -> &wire.PingFrame{} 2025/04/30 11:18:10 client Loss detection alarm for Handshake fired in PTO mode. PTO count: 2 2025/04/30 11:18:10 client -> Sending packet 4 (37 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 2, Length: 20, Version: v1} 2025/04/30 11:18:10 client -> &wire.PingFrame{} 2025/04/30 11:18:10 client -> Sending packet 5 (37 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 2, Length: 20, Version: v1} 2025/04/30 11:18:10 client -> &wire.PingFrame{} 2025/04/30 11:18:10 client <- Reading packet 3 (1252 bytes) for connection (empty), Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 3, PacketNumberLen: 1, Length: 1235, Version: v1} 2025/04/30 11:18:10 client <- &wire.AckFrame{LargestAcked: 5, LowestAcked: 5, DelayTime: 0s} 2025/04/30 11:18:10 client Peer doesn't await address validation any longer. 2025/04/30 11:18:10 client newly acked packets (1): [5] 2025/04/30 11:18:10 client updated RTT: 39.571ms (σ: 17.027ms) 2025/04/30 11:18:10 client Canceling loss detection timer. 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 3505, Data length: 47, Offset + Data length: 3552} 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 3552, Data length: 1157, Offset + Data length: 4709} 2025/04/30 11:18:10 client -> Sending packet 6 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:10 client <- Reading packet 4 (1252 bytes) for connection (empty), Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 4, PacketNumberLen: 1, Length: 1235, Version: v1} 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 4709, Data length: 1213, Offset + Data length: 5922} 2025/04/30 11:18:10 client -> Sending packet 7 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 7, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 4, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:10 client <- Reading packet 5 (1252 bytes) for connection (empty), Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 5, PacketNumberLen: 1, Length: 1235, Version: v1} 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 5922, Data length: 1213, Offset + Data length: 7135} 2025/04/30 11:18:10 client -> Sending packet 8 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 8, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:10 client <- Reading packet 6 (1252 bytes) for connection (empty), Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 6, PacketNumberLen: 1, Length: 1235, Version: v1} 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 7135, Data length: 1213, Offset + Data length: 8348} 2025/04/30 11:18:10 client -> Sending packet 9 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 9, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 6, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:10 client <- Reading packet 7 (1252 bytes) for connection (empty), Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 7, PacketNumberLen: 1, Length: 1235, Version: v1} 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 8348, Data length: 1213, Offset + Data length: 9561} 2025/04/30 11:18:10 client -> Sending packet 10 (40 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 10, PacketNumberLen: 2, Length: 23, Version: v1} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 7, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:10 client <- Reading packet 8 (454 bytes) for connection (empty), Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 8, PacketNumberLen: 1, Length: 437, Version: v1} 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 9561, Data length: 415, Offset + Data length: 9976} 2025/04/30 11:18:10 client Installed 1-RTT Write keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:18:10 client Installed 1-RTT Read keys (using TLS_AES_256_GCM_SHA384) 2025/04/30 11:18:10 client -> Sending packet 11 (95 bytes) for connection 74f52f2e1c681a98b1eb, Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: a53b1c8af6cc27dc, SrcConnectionID: (empty), PacketNumber: 11, PacketNumberLen: 2, Length: 78, Version: v1} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 8, LowestAcked: 0, DelayTime: 0s} 2025/04/30 11:18:10 client -> &wire.CryptoFrame{Offset: 0, Data length: 52, Offset + Data length: 52} 2025/04/30 11:18:10 client -> Sending packet 0 (46 bytes) for connection 74f52f2e1c681a98b1eb, 1-RTT (ECN: ECT(0)) 2025/04/30 11:18:10 client Short Header{DestConnectionID: a53b1c8af6cc27dc, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:18:10 client -> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17} 2025/04/30 11:18:10 client Parsed a coalesced packet. Part 1: 38 bytes. Remaining: 568 bytes. 2025/04/30 11:18:10 client <- Reading packet 9 (38 bytes) for connection (empty), Handshake 2025/04/30 11:18:10 client Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: a53b1c8af6cc27dc, PacketNumber: 9, PacketNumberLen: 1, Length: 22, Version: v1} 2025/04/30 11:18:10 client <- &wire.AckFrame{LargestAcked: 11, LowestAcked: 5, DelayTime: 0s} 2025/04/30 11:18:10 client newly acked packets (1): [11] 2025/04/30 11:18:10 client updated RTT: 38.688ms (σ: 14.535ms) 2025/04/30 11:18:10 client Canceling loss detection timer. 2025/04/30 11:18:10 client <- Reading packet 0 (568 bytes) for connection (empty), 1-RTT 2025/04/30 11:18:10 client Short Header{DestConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:18:10 client <- &wire.CryptoFrame{Offset: 0, Data length: 546, Offset + Data length: 546} 2025/04/30 11:18:10 client Queueing ACK because the first packet should be acknowledged. 2025/04/30 11:18:10 client -> Sending packet 1 (32 bytes) for connection 74f52f2e1c681a98b1eb, 1-RTT (ECN: ECT(0)) 2025/04/30 11:18:10 client Short Header{DestConnectionID: a53b1c8af6cc27dc, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 124.053µs} 2025/04/30 11:18:10 client <- Reading packet 1 (148 bytes) for connection (empty), 1-RTT 2025/04/30 11:18:10 client Short Header{DestConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:18:10 client <- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 2ms} 2025/04/30 11:18:10 client newly acked packets (1): [0] 2025/04/30 11:18:10 client updated RTT: 38.004ms (σ: 12.268ms) 2025/04/30 11:18:10 client Disabling ECN. ECN-marked packet acknowledged, but no ECN counts on ACK frame. 2025/04/30 11:18:10 client Dropping Handshake keys. 2025/04/30 11:18:10 client <- &wire.HandshakeDoneFrame{} 2025/04/30 11:18:10 client <- &wire.NewTokenFrame{Token: 0xb7fa134f7c65265feb54516edea8f3c8c829457009b7ef04e8385a7fb4bf4b92a1e1025ec9} 2025/04/30 11:18:10 client <- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 829af1b0bb1875a4, StatelessResetToken: 0x628b430bba73b58638acca5cfc5ac42c} 2025/04/30 11:18:10 client <- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 8a5ddc3d8faa3c7a, StatelessResetToken: 0x1ff53497781e7dfd7472edbdc67ecd99} 2025/04/30 11:18:10 client <- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: dc2f84cf8ca8502d, StatelessResetToken: 0x3d7cac85ac8ac30281e0e4ed2f9ec82c} 2025/04/30 11:18:10 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:18:10 client -> Sending packet 2 (34 bytes) for connection 74f52f2e1c681a98b1eb, 1-RTT (ECN: Not-ECT) 2025/04/30 11:18:10 client Short Header{DestConnectionID: 829af1b0bb1875a4, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 85.541µs} 2025/04/30 11:18:10 client -> &wire.RetireConnectionIDFrame{SequenceNumber: 0} 2025/04/30 11:18:10 client <- Reading packet 2 (1252 bytes) for connection (empty), 1-RTT 2025/04/30 11:18:10 client Short Header{DestConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:18:10 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1230, Offset + Data length: 1230} 2025/04/30 11:18:10 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:18:10 client <- Reading packet 3 (1252 bytes) for connection (empty), 1-RTT 2025/04/30 11:18:10 client Short Header{DestConnectionID: (empty), PacketNumber: 3, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:18:10 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1230, Data length: 1228, Offset + Data length: 2458} 2025/04/30 11:18:10 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:18:10 client -> Sending packet 3 (32 bytes) for connection 74f52f2e1c681a98b1eb, 1-RTT (ECN: Not-ECT) 2025/04/30 11:18:10 client Short Header{DestConnectionID: 829af1b0bb1875a4, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 69.691µs} 2025/04/30 11:18:10 client <- Reading packet 4 (1252 bytes) for connection (empty), 1-RTT 2025/04/30 11:18:10 client Short Header{DestConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:18:10 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2458, Data length: 1228, Offset + Data length: 3686} 2025/04/30 11:18:10 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:18:10 client <- Reading packet 5 (1252 bytes) for connection (empty), 1-RTT 2025/04/30 11:18:10 client Short Header{DestConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:18:10 client <- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3686, Data length: 1228, Offset + Data length: 4914} 2025/04/30 11:18:10 client Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 11:18:10 client -> Sending packet 4 (32 bytes) for connection 74f52f2e1c681a98b1eb, 1-RTT (ECN: Not-ECT) 2025/04/30 11:18:10 client Short Header{DestConnectionID: 829af1b0bb1875a4, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:18:10 client -> &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 47.469µs} 2025/04/30 11:18:10 client <- Reading packet 6 (230 bytes) for connection (empty), 1-RTT 2025/04/30 11:18:10 client Short Header{DestConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 1, KeyPhase: 0} 2025/04/30 11:18:10 client <- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 4914, Data length: 206, Offset + Data length: 5120} 2025/04/30 11:18:10 client Setting ACK timer to max ack delay: 25ms 2025/04/30 11:18:10 client Closing connection with error: Application error 0x0 (local) 2025/04/30 11:18:10 client -> Sending packet 5 (30 bytes) for connection 74f52f2e1c681a98b1eb, 1-RTT (ECN: Not-ECT) 2025/04/30 11:18:10 client Short Header{DestConnectionID: 829af1b0bb1875a4, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 11:18:10 client -> &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""} 2025/04/30 11:18:10 Replacing connection for connection IDs [(empty)] with a closed connection. 2025/04/30 11:18:10 client Connection 74f52f2e1c681a98b1eb closed.