2025/04/30 09:10:16 Requesting https://server4:443/nkoseidbxc.
2025/04/30 09:10:16 Increased receive buffer size to 14336 kiB
2025/04/30 09:10:16 Increased send buffer size to 14336 kiB
2025/04/30 09:10:16 Setting DF for IPv4 and IPv6.
2025/04/30 09:10:16 Activating reading of ECN bits for IPv4 and IPv6.
2025/04/30 09:10:16 Activating reading of packet info for IPv4 and IPv6.
2025/04/30 09:10:16 Created qlog file: /logs/qlog/2cbc2d320dad3d6b4fd8fd81.sqlog
2025/04/30 09:10:16 client Starting new connection to server4 ([::]:43268 -> 193.167.100.100:443), source connection ID (empty), destination connection ID 2cbc2d320dad3d6b4fd8fd81, version v1
2025/04/30 09:10:16 Adding connection ID (empty).
2025/04/30 09:10:16 client Not doing 0-RTT. Has sealer: false, has params: false
2025/04/30 09:10:16 client -> Sending packet 0 (1280 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, Initial
2025/04/30 09:10:16 client 	Long Header{Type: Initial, DestConnectionID: 2cbc2d320dad3d6b4fd8fd81, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 1258, Version: v1}
2025/04/30 09:10:16 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 262, Offset + Data length: 262}
2025/04/30 09:10:16 client 	updated RTT: 36.754942ms (σ: 18.377471ms)
2025/04/30 09:10:16 client <- Received Retry:
2025/04/30 09:10:16 client 	Long Header{Type: Retry, DestConnectionID: (empty), SrcConnectionID: 929592a3ed04196b, Token: 0x58cbc3c81d07478170aa29505db6470c5d1b00eb2c4a30e52e5ba576a6ccabd504d529c3773f4adffa670618c7bbcd637c4eca2d1baa4e, Version: v1}
2025/04/30 09:10:16 client Switching destination connection ID to: 929592a3ed04196b
2025/04/30 09:10:16 client -> Sending packet 1 (1280 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, Initial
2025/04/30 09:10:16 client 	Long Header{Type: Initial, DestConnectionID: 929592a3ed04196b, SrcConnectionID: (empty), Token: 0x58cbc3c81d07478170aa29505db6470c5d1b00eb2c4a30e52e5ba576a6ccabd504d529c3773f4adffa670618c7bbcd637c4eca2d1baa4e, PacketNumber: 1, PacketNumberLen: 2, Length: 1207, Version: v1}
2025/04/30 09:10:16 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 262, Offset + Data length: 262}
2025/04/30 09:10:16 client Parsed a coalesced packet. Part 1: 138 bytes. Remaining: 1114 bytes.
2025/04/30 09:10:16 client <- Reading packet 76426 (138 bytes) for connection (empty), Initial
2025/04/30 09:10:16 client 	Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: 4bc050b4fbe5eeba, Token: (empty), PacketNumber: 76426, PacketNumberLen: 4, Length: 120, Version: v1}
2025/04/30 09:10:16 client Received first packet. Switching destination connection ID to: 4bc050b4fbe5eeba
2025/04/30 09:10:16 client 	<- &wire.AckFrame{LargestAcked: 1, LowestAcked: 1, DelayTime: 744µs}
2025/04/30 09:10:16 client 	newly acked packets (1): [1]
2025/04/30 09:10:16 client 	updated RTT: 36.318ms (σ: 14.653ms)
2025/04/30 09:10:16 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90}
2025/04/30 09:10:16 client Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:10:16 client Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:10:16 client Parsed a coalesced packet. Part 2: 757 bytes. Remaining: 357 bytes.
2025/04/30 09:10:16 client <- Reading packet 0 (757 bytes) for connection (empty), Handshake
2025/04/30 09:10:16 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 4bc050b4fbe5eeba, PacketNumber: 0, PacketNumberLen: 4, Length: 740, Version: v1}
2025/04/30 09:10:16 client 	<- &wire.CryptoFrame{Offset: 0, Data length: 716, Offset + Data length: 716}
2025/04/30 09:10:16 client Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:10:16 client Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 09:10:16 client Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: 2cbc2d320dad3d6b4fd8fd81, InitialSourceConnectionID: 4bc050b4fbe5eeba, RetrySourceConnectionID: 929592a3ed04196b, InitialMaxStreamDataBidiLocal: 2097152, InitialMaxStreamDataBidiRemote: 65635, InitialMaxStreamDataUni: 65535, InitialMaxData: 1048576, MaxBidiStreamNum: 512, MaxUniStreamNum: 512, MaxIdleTimeout: 3m0s, AckDelayExponent: 3, MaxAckDelay: 10ms, ActiveConnectionIDLimit: 8, StatelessResetToken: 0x728313be06af7037d610e2ddec7e2844}
2025/04/30 09:10:16 client Parsed a coalesced packet. Part 3: 357 bytes. Remaining: 0 bytes.
2025/04/30 09:10:16 client <- Reading packet 1 (357 bytes) for connection (empty), Handshake
2025/04/30 09:10:16 client 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 4bc050b4fbe5eeba, PacketNumber: 1, PacketNumberLen: 4, Length: 340, Version: v1}
2025/04/30 09:10:16 client 	<- &wire.PingFrame{}
2025/04/30 09:10:16 client -> Sending coalesced packet (2 parts, 1280 bytes) for connection 2cbc2d320dad3d6b4fd8fd81
2025/04/30 09:10:16 client 	Long Header{Type: Initial, DestConnectionID: 4bc050b4fbe5eeba, SrcConnectionID: (empty), Token: 0x58cbc3c81d07478170aa29505db6470c5d1b00eb2c4a30e52e5ba576a6ccabd504d529c3773f4adffa670618c7bbcd637c4eca2d1baa4e, PacketNumber: 2, PacketNumberLen: 2, Length: 1133, Version: v1}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 76426, LowestAcked: 76426, DelayTime: 0s, ECT0: 0, ECT1: 1, CE: 0}
2025/04/30 09:10:16 client 	Long Header{Type: Handshake, DestConnectionID: 4bc050b4fbe5eeba, SrcConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 57, Version: v1}
2025/04/30 09:10:16 client 	-> &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36}
2025/04/30 09:10:16 client Dropping Initial keys.
2025/04/30 09:10:16 client <- Reading packet 0 (183 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.NewTokenFrame{Token: 0x92203231812f07112184764145bee09b73674edc950cd3b924d4642407c72cfa24b5dbeed6db2deb70deae605a89f201385f}
2025/04/30 09:10:16 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 43d0261270432777, StatelessResetToken: 0x26cebb0ecc98f41fd9a3fa7696a107f5}
2025/04/30 09:10:16 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 2641c5af006a3505, StatelessResetToken: 0x3bc606b763b1fdd59857e6822804e44c}
2025/04/30 09:10:16 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: 9c36fe79cff5f452, StatelessResetToken: 0xf4809b6fc29f1d027e11b3af1ead3054}
2025/04/30 09:10:16 client 	Queueing ACK because the first packet should be acknowledged.
2025/04/30 09:10:16 client -> Sending packet 1 (91 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, Handshake
2025/04/30 09:10:16 client 	Long Header{Type: Handshake, DestConnectionID: 43d0261270432777, SrcConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 2, Length: 26, Version: v1}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 0s, ECT0: 0, ECT1: 2, CE: 0}
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.RetireConnectionIDFrame{SequenceNumber: 0}
2025/04/30 09:10:16 client 	-> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 09:10:16 client -> Sending packet 1 (36 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, 1-RTT (ECN: ECT(0))
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 769.684µs, ECT0: 0, ECT1: 1, CE: 0}
2025/04/30 09:10:16 client <- Reading packet 1 (1452 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.PingFrame{}
2025/04/30 09:10:16 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:10:16 client Sending ACK because the ACK timer expired.
2025/04/30 09:10:16 client -> Sending packet 2 (36 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, 1-RTT (ECN: ECT(0))
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 25.231342ms, ECT0: 0, ECT1: 2, CE: 0}
2025/04/30 09:10:16 client <- Reading packet 2 (1252 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 16µs, ECT0: 1, ECT1: 0, CE: 0}
2025/04/30 09:10:16 client Peer doesn't await address validation any longer.
2025/04/30 09:10:16 client 	newly acked packets (1): [0]
2025/04/30 09:10:16 client Canceling loss detection timer.
2025/04/30 09:10:16 client Dropping Handshake keys.
2025/04/30 09:10:16 client 	<- &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: aab11ab6e4f9b64e, StatelessResetToken: 0xd507e5537d3998a99d5a85e226a1c260}
2025/04/30 09:10:16 client 	<- &wire.HandshakeDoneFrame{}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1195, Offset + Data length: 1195}
2025/04/30 09:10:16 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:10:16 client <- Reading packet 3 (1252 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 3, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1195, Data length: 1230, Offset + Data length: 2425}
2025/04/30 09:10:16 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:10:16 client -> Sending packet 3 (35 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, 1-RTT (ECN: ECT(0))
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 45.073µs, ECT0: 0, ECT1: 4, CE: 0}
2025/04/30 09:10:16 client <- Reading packet 4 (1252 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2425, Data length: 1230, Offset + Data length: 3655}
2025/04/30 09:10:16 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:10:16 client <- Reading packet 5 (1252 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3655, Data length: 1230, Offset + Data length: 4885}
2025/04/30 09:10:16 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:10:16 client -> Sending packet 4 (35 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, 1-RTT (ECN: ECT(0))
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 42.991µs, ECT0: 0, ECT1: 6, CE: 0}
2025/04/30 09:10:16 client <- Reading packet 6 (1252 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4885, Data length: 1230, Offset + Data length: 6115}
2025/04/30 09:10:16 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:10:16 client <- Reading packet 7 (1452 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 7, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6115, Data length: 1430, Offset + Data length: 7545}
2025/04/30 09:10:16 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:10:16 client -> Sending packet 5 (35 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, 1-RTT (ECN: ECT(0))
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 7, LowestAcked: 0, DelayTime: 65.242µs, ECT0: 0, ECT1: 8, CE: 0}
2025/04/30 09:10:16 client <- Reading packet 8 (1452 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 8, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7545, Data length: 1430, Offset + Data length: 8975}
2025/04/30 09:10:16 client 	Setting ACK timer to max ack delay: 25ms
2025/04/30 09:10:16 client <- Reading packet 9 (1335 bytes) for connection (empty), 1-RTT
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: (empty), PacketNumber: 9, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 09:10:16 client 	<- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 8975, Data length: 1265, Offset + Data length: 10240}
2025/04/30 09:10:16 client 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 09:10:16 client -> Sending packet 6 (35 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, 1-RTT (ECN: ECT(0))
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.AckFrame{LargestAcked: 9, LowestAcked: 0, DelayTime: 54.752µs, ECT0: 0, ECT1: 10, CE: 0}
2025/04/30 09:10:16 client Closing connection with error: Application error 0x0 (local)
2025/04/30 09:10:16 client -> Sending packet 7 (30 bytes) for connection 2cbc2d320dad3d6b4fd8fd81, 1-RTT (ECN: ECT(0))
2025/04/30 09:10:16 client 	Short Header{DestConnectionID: 43d0261270432777, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 09:10:16 client 	-> &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""}
2025/04/30 09:10:16 Replacing connection for connection IDs [(empty)] with a closed connection.
2025/04/30 09:10:16 client Connection 2cbc2d320dad3d6b4fd8fd81 closed.