2025/04/30 08:43:30 Increased receive buffer size to 14336 kiB
2025/04/30 08:43:30 Increased send buffer size to 14336 kiB
2025/04/30 08:43:30 Setting DF for IPv4 and IPv6.
2025/04/30 08:43:30 Activating reading of ECN bits for IPv4 and IPv6.
2025/04/30 08:43:30 Activating reading of packet info for IPv4 and IPv6.
2025/04/30 08:43:30 server Listening for udp connections on [::]:443
2025/04/30 08:43:31 server Client offered version 0x57414954, sending Version Negotiation
2025/04/30 08:43:31 server Client offered version 0x57414954, sending Version Negotiation
2025/04/30 08:43:31 server Client offered version 0x57414954, sending Version Negotiation
2025/04/30 08:43:32 Tracking 0 connection IDs and 0 reset tokens.
2025/04/30 08:43:34 server <- Received Initial packet.
2025/04/30 08:43:34 server 	Long Header{Type: Initial, DestConnectionID: d6b0e1e7729aefcc42990a0144f3774f03f8c921, SrcConnectionID: d14946efbc456d1c, Token: (empty), PacketNumber: 0, PacketNumberLen: 0, Length: 1162, Version: v1}
2025/04/30 08:43:34 server Changing connection ID to e3ad7160.
2025/04/30 08:43:34 server -> Sending Retry
2025/04/30 08:43:34 server 	Long Header{Type: Retry, DestConnectionID: d14946efbc456d1c, SrcConnectionID: e3ad7160, Token: 0x36513761f50780139bbf7cef68b1f950fb8d3e045b19a10f9b9db2a9d2d9e04f1346ee59cec15ac5920d62872416da313dafe021f1c3d05072b58d8e4c9ab2aa512fcc8a45aa0b318a62671f79d2c1c3f086d4dc29b0e8c9c9f6629ff5e558b7682f70aca58e3166ad98b6c13292, Version: v1}
2025/04/30 08:43:34 server <- Received Initial packet.
2025/04/30 08:43:34 Created qlog file: /logs/qlog/d6b0e1e7729aefcc42990a0144f3774f03f8c921.sqlog
2025/04/30 08:43:34 server Changing connection ID to 1c44f5cb.
2025/04/30 08:43:34 Adding connection IDs e3ad7160 and 1c44f5cb for a new connection.
2025/04/30 08:43:34 server <- Reading packet 1 (1200 bytes) for connection e3ad7160, Initial
2025/04/30 08:43:34 server 	Long Header{Type: Initial, DestConnectionID: e3ad7160, SrcConnectionID: d14946efbc456d1c, Token: 0x36513761f50780139bbf7cef68b1f950fb8d3e045b19a10f9b9db2a9d2d9e04f1346ee59cec15ac5920d62872416da313dafe021f1c3d05072b58d8e4c9ab2aa512fcc8a45aa0b318a62671f79d2c1c3f086d4dc29b0e8c9c9f6629ff5e558b7682f70aca58e3166ad98b6c13292, PacketNumber: 1, PacketNumberLen: 1, Length: 1067, Version: v1}
2025/04/30 08:43:34 server 	<- &wire.CryptoFrame{Offset: 0, Data length: 286, Offset + Data length: 286}
2025/04/30 08:43:34 server Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:43:34 server Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:43:34 server Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:43:34 server Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: (empty), InitialSourceConnectionID: d14946efbc456d1c, InitialMaxStreamDataBidiLocal: 1250000, InitialMaxStreamDataBidiRemote: 1250000, InitialMaxStreamDataUni: 1250000, InitialMaxData: 4611686018427387903, MaxBidiStreamNum: 100, MaxUniStreamNum: 100, MaxIdleTimeout: 30s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 5, MaxDatagramFrameSize: 65535}
2025/04/30 08:43:34 Adding connection ID aaf4ed7c.
2025/04/30 08:43:34 Adding connection ID 216544bb.
2025/04/30 08:43:34 Adding connection ID c240f9a2.
2025/04/30 08:43:34 Adding connection ID b55b7f3e.
2025/04/30 08:43:34 server -> Sending coalesced packet (2 parts, 1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921
2025/04/30 08:43:34 server 	Long Header{Type: Initial, DestConnectionID: d14946efbc456d1c, SrcConnectionID: 1c44f5cb, Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 367, Version: v1}
2025/04/30 08:43:34 server 	-> &wire.AckFrame{LargestAcked: 1, LowestAcked: 1, DelayTime: 0s, ECT0: 1, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	-> &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90}
2025/04/30 08:43:34 server 	Long Header{Type: Handshake, DestConnectionID: d14946efbc456d1c, SrcConnectionID: 1c44f5cb, PacketNumber: 0, PacketNumberLen: 2, Length: 747, Version: v1}
2025/04/30 08:43:34 server 	-> &wire.CryptoFrame{Offset: 0, Data length: 725, Offset + Data length: 725}
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: d14946efbc456d1c, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: b55b7f3e, StatelessResetToken: 0x32d94bd0d926863b829b75f92f519901}
2025/04/30 08:43:34 server 	-> &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: c240f9a2, StatelessResetToken: 0x2e75e6083cfa8f36296e5ac361c622b4}
2025/04/30 08:43:34 server 	-> &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 216544bb, StatelessResetToken: 0x84b13e5f0a0bea066891194f20b74864}
2025/04/30 08:43:34 server 	-> &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: aaf4ed7c, StatelessResetToken: 0x536f105bde5dbcbb5cc1fa548c9932a2}
2025/04/30 08:43:34 server Parsed a coalesced packet. Part 1: 155 bytes. Remaining: 1045 bytes.
2025/04/30 08:43:34 server <- Reading packet 2 (155 bytes) for connection 1c44f5cb, Initial
2025/04/30 08:43:34 server 	Long Header{Type: Initial, DestConnectionID: 1c44f5cb, SrcConnectionID: d14946efbc456d1c, Token: 0x36513761f50780139bbf7cef68b1f950fb8d3e045b19a10f9b9db2a9d2d9e04f1346ee59cec15ac5920d62872416da313dafe021f1c3d05072b58d8e4c9ab2aa512fcc8a45aa0b318a62671f79d2c1c3f086d4dc29b0e8c9c9f6629ff5e558b7682f70aca58e3166ad98b6c13292, PacketNumber: 2, PacketNumberLen: 1, Length: 22, Version: v1}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 400µs}
2025/04/30 08:43:34 server 	newly acked packets (1): [0]
2025/04/30 08:43:34 server 	updated RTT: 33.322989ms (σ: 16.661494ms)
2025/04/30 08:43:34 server Parsed a coalesced packet. Part 2: 1045 bytes. Remaining: 0 bytes.
2025/04/30 08:43:34 server <- Reading packet 0 (1045 bytes) for connection 1c44f5cb, Handshake
2025/04/30 08:43:34 server 	Long Header{Type: Handshake, DestConnectionID: 1c44f5cb, SrcConnectionID: d14946efbc456d1c, PacketNumber: 0, PacketNumberLen: 1, Length: 1024, Version: v1}
2025/04/30 08:43:34 server Dropping Initial keys.
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 400µs}
2025/04/30 08:43:34 server 	newly acked packets (1): [0]
2025/04/30 08:43:34 server 	updated RTT: 33.322ms (σ: 12.495ms)
2025/04/30 08:43:34 server Canceling loss detection timer.
2025/04/30 08:43:34 server 	<- &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36}
2025/04/30 08:43:34 server Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 08:43:34 Retiring connection ID e3ad7160 in 5s.
2025/04/30 08:43:34 server Dropping Handshake keys.
2025/04/30 08:43:34 server <- Reading packet 0 (106 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 0, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: b887b8aa961ef26d, StatelessResetToken: 0xdaf2a577d2fcfa2a0f7ff63b77b20b73}
2025/04/30 08:43:34 server 	<- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: c80fc9f887ac3977, StatelessResetToken: 0x2d59714e0b3641f74ec9c69f51e432ba}
2025/04/30 08:43:34 server 	<- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: 2b3588000055178e, StatelessResetToken: 0xf9b390afc3933c92001d1d4aa6d2f021}
2025/04/30 08:43:34 server 	Queueing ACK because the first packet should be acknowledged.
2025/04/30 08:43:34 server <- Reading packet 1 (42 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 1, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 08:43:34 server -> Sending packet 1 (269 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 405.519µs, ECT0: 2, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	-> &wire.HandshakeDoneFrame{}
2025/04/30 08:43:34 server 	-> &wire.NewTokenFrame{Token: 0x9f6114ecaff2d000a6981729ee16103fdd88121c6394b172e4528835ca9b568c7d4bd4636349c7fab065527765b25b870e8f049c9861756251dc97f22ad004feb6113cd11ee67ede92513f3c9ebcd680bfe98517d0ca}
2025/04/30 08:43:34 server 	-> &wire.CryptoFrame{Offset: 0, Data length: 138, Offset + Data length: 138}
2025/04/30 08:43:34 server 	-> &wire.RetireConnectionIDFrame{SequenceNumber: 0}
2025/04/30 08:43:34 Received request: GET /rnjvinwihz
2025/04/30 08:43:34 server -> Sending packet 2 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1251, Offset + Data length: 1251}
2025/04/30 08:43:34 server -> Sending packet 3 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1251, Data length: 1249, Offset + Data length: 2500}
2025/04/30 08:43:34 server -> Sending packet 4 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2500, Data length: 1249, Offset + Data length: 3749}
2025/04/30 08:43:34 server -> Sending packet 5 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3749, Data length: 1249, Offset + Data length: 4998}
2025/04/30 08:43:34 server -> Sending packet 6 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4998, Data length: 1249, Offset + Data length: 6247}
2025/04/30 08:43:34 server -> Sending packet 7 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6247, Data length: 1249, Offset + Data length: 7496}
2025/04/30 08:43:34 server -> Sending packet 8 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7496, Data length: 1249, Offset + Data length: 8745}
2025/04/30 08:43:34 server -> Sending packet 9 (1280 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 8745, Data length: 1249, Offset + Data length: 9994}
2025/04/30 08:43:34 server -> Sending packet 10 (277 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: ECT(0))
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 10, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 9994, Data length: 246, Offset + Data length: 10240}
2025/04/30 08:43:34 server -> Sending packet 11 (31 bytes) for connection d6b0e1e7729aefcc42990a0144f3774f03f8c921, 1-RTT (ECN: Not-ECT)
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: b887b8aa961ef26d, PacketNumber: 11, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 08:43:34 server 	-> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 10240, Data length: 0, Offset + Data length: 10240}
2025/04/30 08:43:34 server <- Reading packet 2 (30 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 2, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 1, LowestAcked: 0, DelayTime: 104µs, ECT0: 1, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	newly acked packets (2): [0 1]
2025/04/30 08:43:34 server 	updated RTT: 33.035ms (σ: 9.944ms)
2025/04/30 08:43:34 server ECN capability confirmed.
2025/04/30 08:43:34 server 	Ignoring all packets below 2.
2025/04/30 08:43:34 server <- Reading packet 3 (50 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 3, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: 93d512112102860a, StatelessResetToken: 0x53b787e5636ab2cd1c5d8e1a57d46703}
2025/04/30 08:43:34 server 	Setting ACK timer to max ack delay: 25ms
2025/04/30 08:43:34 server <- Reading packet 4 (30 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 4, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 16µs, ECT0: 3, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	newly acked packets (2): [2 3]
2025/04/30 08:43:34 server 	updated RTT: 33.003ms (σ: 7.521ms)
2025/04/30 08:43:34 server <- Reading packet 5 (30 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 5, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 16µs, ECT0: 5, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	newly acked packets (2): [4 5]
2025/04/30 08:43:34 server 	updated RTT: 33.237ms (σ: 6.109ms)
2025/04/30 08:43:34 server <- Reading packet 6 (30 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 6, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 7, LowestAcked: 0, DelayTime: 16µs, ECT0: 7, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	newly acked packets (2): [6 7]
2025/04/30 08:43:34 server 	updated RTT: 33.7ms (σ: 5.508ms)
2025/04/30 08:43:34 server <- Reading packet 7 (30 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 7, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 9, LowestAcked: 0, DelayTime: 8µs, ECT0: 9, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	newly acked packets (2): [8 9]
2025/04/30 08:43:34 server 	updated RTT: 34.368ms (σ: 5.468ms)
2025/04/30 08:43:34 server <- Reading packet 8 (30 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 8, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 11, LowestAcked: 0, DelayTime: 8µs, ECT0: 10, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	newly acked packets (2): [10 11]
2025/04/30 08:43:34 server 	updated RTT: 34.987ms (σ: 5.34ms)
2025/04/30 08:43:34 server Canceling loss detection timer.
2025/04/30 08:43:34 server <- Reading packet 9 (33 bytes) for connection 1c44f5cb, 1-RTT
2025/04/30 08:43:34 server 	Short Header{DestConnectionID: 1c44f5cb, PacketNumber: 9, PacketNumberLen: 1, KeyPhase: 0}
2025/04/30 08:43:34 server 	<- &wire.AckFrame{LargestAcked: 11, LowestAcked: 0, DelayTime: 104µs, ECT0: 10, ECT1: 0, CE: 0}
2025/04/30 08:43:34 server 	<- &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""}
2025/04/30 08:43:34 server Closing connection with error: Application error 0x0 (remote)
2025/04/30 08:43:34 Replacing connection for connection IDs [1c44f5cb aaf4ed7c 216544bb c240f9a2 b55b7f3e] with a closed connection.
2025/04/30 08:43:34 Error accepting stream: Application error 0x0 (remote)
2025/04/30 08:43:34 server Connection d6b0e1e7729aefcc42990a0144f3774f03f8c921 closed.
2025/04/30 08:43:36 Tracking 6 connection IDs and 0 reset tokens.
2025/04/30 08:43:38 Tracking 6 connection IDs and 0 reset tokens.
2025/04/30 08:43:39 Removing connection ID e3ad7160 after it has been retired.
2025/04/30 08:43:39 Removing connection IDs [1c44f5cb aaf4ed7c 216544bb c240f9a2 b55b7f3e] for a closed connection after it has been retired.
2025/04/30 08:43:40 Tracking 0 connection IDs and 0 reset tokens.