2025/04/30 11:06:18 Increased receive buffer size to 14336 kiB
2025/04/30 11:06:18 Increased send buffer size to 14336 kiB
2025/04/30 11:06:18 Setting DF for IPv4 and IPv6.
2025/04/30 11:06:18 Activating reading of ECN bits for IPv4 and IPv6.
2025/04/30 11:06:18 Activating reading of packet info for IPv4 and IPv6.
2025/04/30 11:06:18 server Listening for udp connections on [::]:443
2025/04/30 11:06:19 server Client offered version 0x57414954, sending Version Negotiation
2025/04/30 11:06:19 server Client offered version 0x57414954, sending Version Negotiation
2025/04/30 11:06:19 server Client offered version 0x57414954, sending Version Negotiation
2025/04/30 11:06:19 server <- Received Initial packet.
2025/04/30 11:06:19 server 	Long Header{Type: Initial, DestConnectionID: ac719766cc2fa6be, SrcConnectionID: (empty), Token: (empty), PacketNumber: 0, PacketNumberLen: 0, Length: 1202, Version: v1}
2025/04/30 11:06:19 server Changing connection ID to e0fad5b4.
2025/04/30 11:06:19 server -> Sending Retry
2025/04/30 11:06:19 server 	Long Header{Type: Retry, DestConnectionID: (empty), SrcConnectionID: e0fad5b4, Token: 0x476b370b83eb4c261cc730a8f7fc81c63dfa09dd4e828e0b27923847560d241e34643283957f727a63694089b90e30d1d75b1c1be98f9c0fa5f7592d13dbbe75938fcf7ad0926085693e1635793fe4f8a134c4da19d463463d4c46b6971e20480569, Version: v1}
2025/04/30 11:06:19 server <- Received Initial packet.
2025/04/30 11:06:19 Created qlog file: /logs/qlog/ac719766cc2fa6be.sqlog
2025/04/30 11:06:19 server Changing connection ID to 72331eea.
2025/04/30 11:06:19 Adding connection IDs e0fad5b4 and 72331eea for a new connection.
2025/04/30 11:06:19 server <- Reading packet 1 (1220 bytes) for connection e0fad5b4, Initial
2025/04/30 11:06:19 server 	Long Header{Type: Initial, DestConnectionID: e0fad5b4, SrcConnectionID: (empty), Token: 0x476b370b83eb4c261cc730a8f7fc81c63dfa09dd4e828e0b27923847560d241e34643283957f727a63694089b90e30d1d75b1c1be98f9c0fa5f7592d13dbbe75938fcf7ad0926085693e1635793fe4f8a134c4da19d463463d4c46b6971e20480569, PacketNumber: 1, PacketNumberLen: 4, Length: 1107, Version: v1}
2025/04/30 11:06:19 server 	<- &wire.CryptoFrame{Offset: 0, Data length: 288, Offset + Data length: 288}
2025/04/30 11:06:19 server Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 11:06:19 server Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 11:06:19 server Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 11:06:19 server Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: (empty), InitialSourceConnectionID: (empty), InitialMaxStreamDataBidiLocal: 65536, InitialMaxStreamDataBidiRemote: 65536, InitialMaxStreamDataUni: 65536, InitialMaxData: 16777216, MaxBidiStreamNum: 0, MaxUniStreamNum: 3, MaxIdleTimeout: 10s, AckDelayExponent: 8, MaxAckDelay: 26ms, ActiveConnectionIDLimit: 4}
2025/04/30 11:06:19 Adding connection ID 4f1e2e6d.
2025/04/30 11:06:19 Adding connection ID bd690477.
2025/04/30 11:06:19 Adding connection ID b58d5dfc.
2025/04/30 11:06:19 server -> Sending coalesced packet (2 parts, 1280 bytes) for connection ac719766cc2fa6be
2025/04/30 11:06:19 server 	Long Header{Type: Initial, DestConnectionID: (empty), SrcConnectionID: 72331eea, Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 430, Version: v1}
2025/04/30 11:06:19 server 	-> &wire.AckFrame{LargestAcked: 1, LowestAcked: 1, DelayTime: 0s}
2025/04/30 11:06:19 server 	-> &wire.CryptoFrame{Offset: 0, Data length: 90, Offset + Data length: 90}
2025/04/30 11:06:19 server 	Long Header{Type: Handshake, DestConnectionID: (empty), SrcConnectionID: 72331eea, PacketNumber: 0, PacketNumberLen: 2, Length: 732, Version: v1}
2025/04/30 11:06:19 server 	-> &wire.CryptoFrame{Offset: 0, Data length: 710, Offset + Data length: 710}
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: bd690477, StatelessResetToken: 0xf8031af00b2cd0708b2b56747cd7321a}
2025/04/30 11:06:19 server 	-> &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: b58d5dfc, StatelessResetToken: 0x7f6a8e699d569ac1dd4ef728f461e6a3}
2025/04/30 11:06:19 server 	-> &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 4f1e2e6d, StatelessResetToken: 0x1ac97c5559b788f2031a664c35d5459f}
2025/04/30 11:06:19 server <- Reading packet 2 (77 bytes) for connection 72331eea, Handshake
2025/04/30 11:06:19 server 	Long Header{Type: Handshake, DestConnectionID: 72331eea, SrcConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 4, Length: 64, Version: v1}
2025/04/30 11:06:19 server Dropping Initial keys.
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 8µs}
2025/04/30 11:06:19 server 	newly acked packets (1): [0]
2025/04/30 11:06:19 server 	updated RTT: 32.287079ms (σ: 16.143539ms)
2025/04/30 11:06:19 server Canceling loss detection timer.
2025/04/30 11:06:19 server 	<- &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36}
2025/04/30 11:06:19 server Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256)
2025/04/30 11:06:19 Retiring connection ID e0fad5b4 in 5s.
2025/04/30 11:06:19 server Dropping Handshake keys.
2025/04/30 11:06:19 server -> Sending packet 1 (251 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.NewTokenFrame{Token: 0xb8630f460eff553e8ff5cb0d12e5c463fd4d44ceb288e2a55232b936b72ddc46f97ffdbfad62649f1d6ee2ef54592106499b9bb4cd04f980f9bdef452d94c26fd9e7be3907082000be137a10f7b5f0865a2b53050c9a}
2025/04/30 11:06:19 server 	-> &wire.HandshakeDoneFrame{}
2025/04/30 11:06:19 server 	-> &wire.CryptoFrame{Offset: 0, Data length: 138, Offset + Data length: 138}
2025/04/30 11:06:19 server <- Reading packet 3 (1252 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 3, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.PingFrame{}
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s}
2025/04/30 11:06:19 server 	newly acked packets (1): [0]
2025/04/30 11:06:19 server 	updated RTT: 32.411ms (σ: 12.355ms)
2025/04/30 11:06:19 server 	<- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17}
2025/04/30 11:06:19 server 	Queueing ACK because the first packet should be acknowledged.
2025/04/30 11:06:19 server -> Sending packet 2 (24 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.AckFrame{LargestAcked: 3, LowestAcked: 3, DelayTime: 92.341µs}
2025/04/30 11:06:19 Received request: GET /fcddnhbmlp
2025/04/30 11:06:19 server -> Sending packet 3 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1259, Offset + Data length: 1259}
2025/04/30 11:06:19 server -> Sending packet 4 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1259, Data length: 1257, Offset + Data length: 2516}
2025/04/30 11:06:19 server -> Sending packet 5 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2516, Data length: 1257, Offset + Data length: 3773}
2025/04/30 11:06:19 server -> Sending packet 6 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3773, Data length: 1257, Offset + Data length: 5030}
2025/04/30 11:06:19 server -> Sending packet 7 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 5030, Data length: 1257, Offset + Data length: 6287}
2025/04/30 11:06:19 server -> Sending packet 8 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6287, Data length: 1257, Offset + Data length: 7544}
2025/04/30 11:06:19 server -> Sending packet 9 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7544, Data length: 1257, Offset + Data length: 8801}
2025/04/30 11:06:19 server -> Sending packet 10 (1280 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 10, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 8801, Data length: 1257, Offset + Data length: 10058}
2025/04/30 11:06:19 server -> Sending packet 11 (205 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: Not-ECT)
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 11, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 10058, Data length: 182, Offset + Data length: 10240}
2025/04/30 11:06:19 server -> Sending packet 12 (23 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: Not-ECT)
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 12, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 10240, Data length: 0, Offset + Data length: 10240}
2025/04/30 11:06:19 server <- Reading packet 4 (1332 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 4, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.PingFrame{}
2025/04/30 11:06:19 server 	Setting ACK timer to max ack delay: 25ms
2025/04/30 11:06:19 server <- Reading packet 5 (44 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 5, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 3, LowestAcked: 1, DelayTime: 0s, ECT0: 3, ECT1: 0, CE: 0}
2025/04/30 11:06:19 server 	newly acked packets (2): [1 3]
2025/04/30 11:06:19 server 	updated RTT: 32.325ms (σ: 9.436ms)
2025/04/30 11:06:19 server ECN capability confirmed.
2025/04/30 11:06:19 server 	<- &wire.MaxDataFrame{MaximumData: 16778475}
2025/04/30 11:06:19 server 	<- &wire.MaxStreamDataFrame{StreamID: 0, MaximumStreamData: 66795}
2025/04/30 11:06:19 server 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 11:06:19 server -> Sending packet 13 (24 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 13, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.AckFrame{LargestAcked: 5, LowestAcked: 3, DelayTime: 100.376µs}
2025/04/30 11:06:19 server <- Reading packet 6 (44 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 6, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 5, LowestAcked: 1, DelayTime: 0s, ECT0: 5, ECT1: 0, CE: 0}
2025/04/30 11:06:19 server 	newly acked packets (2): [4 5]
2025/04/30 11:06:19 server 	updated RTT: 32.515ms (σ: 7.458ms)
2025/04/30 11:06:19 server 	<- &wire.MaxDataFrame{MaximumData: 16780989}
2025/04/30 11:06:19 server 	<- &wire.MaxStreamDataFrame{StreamID: 0, MaximumStreamData: 69309}
2025/04/30 11:06:19 server 	Setting ACK timer to max ack delay: 25ms
2025/04/30 11:06:19 server <- Reading packet 7 (44 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 7, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 7, LowestAcked: 1, DelayTime: 0s, ECT0: 7, ECT1: 0, CE: 0}
2025/04/30 11:06:19 server 	newly acked packets (2): [6 7]
2025/04/30 11:06:19 server 	updated RTT: 32.939ms (σ: 6.442ms)
2025/04/30 11:06:19 server 	<- &wire.MaxDataFrame{MaximumData: 16783503}
2025/04/30 11:06:19 server 	<- &wire.MaxStreamDataFrame{StreamID: 0, MaximumStreamData: 71823}
2025/04/30 11:06:19 server 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 11:06:19 server -> Sending packet 14 (24 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 14, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.AckFrame{LargestAcked: 7, LowestAcked: 3, DelayTime: 59.821µs}
2025/04/30 11:06:19 server <- Reading packet 8 (44 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 8, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 9, LowestAcked: 1, DelayTime: 0s, ECT0: 9, ECT1: 0, CE: 0}
2025/04/30 11:06:19 server 	newly acked packets (2): [8 9]
2025/04/30 11:06:19 server 	updated RTT: 33.571ms (σ: 6.096ms)
2025/04/30 11:06:19 server 	<- &wire.MaxDataFrame{MaximumData: 16786017}
2025/04/30 11:06:19 server 	<- &wire.MaxStreamDataFrame{StreamID: 0, MaximumStreamData: 74337}
2025/04/30 11:06:19 server 	Setting ACK timer to max ack delay: 25ms
2025/04/30 11:06:19 server <- Reading packet 9 (44 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 9, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 11, LowestAcked: 1, DelayTime: 0s, ECT0: 10, ECT1: 0, CE: 0}
2025/04/30 11:06:19 server 	newly acked packets (2): [10 11]
2025/04/30 11:06:19 server 	updated RTT: 34.284ms (σ: 5.999ms)
2025/04/30 11:06:19 server 	<- &wire.MaxDataFrame{MaximumData: 16787456}
2025/04/30 11:06:19 server 	<- &wire.MaxStreamDataFrame{StreamID: 0, MaximumStreamData: 75776}
2025/04/30 11:06:19 server 	Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2).
2025/04/30 11:06:19 server -> Sending packet 15 (24 bytes) for connection ac719766cc2fa6be, 1-RTT (ECN: ECT(0))
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: (empty), PacketNumber: 15, PacketNumberLen: 2, KeyPhase: 0}
2025/04/30 11:06:19 server 	-> &wire.AckFrame{LargestAcked: 9, LowestAcked: 3, DelayTime: 77.343µs}
2025/04/30 11:06:19 server <- Reading packet 10 (36 bytes) for connection 72331eea, 1-RTT
2025/04/30 11:06:19 server 	Short Header{DestConnectionID: 72331eea, PacketNumber: 10, PacketNumberLen: 4, KeyPhase: 0}
2025/04/30 11:06:19 server 	<- &wire.AckFrame{LargestAcked: 12, LowestAcked: 1, DelayTime: 0s, ECT0: 10, ECT1: 0, CE: 0}
2025/04/30 11:06:19 server 	newly acked packets (1): [12]
2025/04/30 11:06:19 server 	updated RTT: 34.909ms (σ: 5.751ms)
2025/04/30 11:06:19 server Canceling loss detection timer.
2025/04/30 11:06:19 server 	<- &wire.ConnectionCloseFrame{IsApplicationError:true, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""}
2025/04/30 11:06:19 server Closing connection with error: Application error 0x0 (remote)
2025/04/30 11:06:19 Replacing connection for connection IDs [72331eea 4f1e2e6d bd690477 b58d5dfc] with a closed connection.
2025/04/30 11:06:19 Error accepting stream: Application error 0x0 (remote)
2025/04/30 11:06:19 server Connection ac719766cc2fa6be closed.
2025/04/30 11:06:20 Tracking 5 connection IDs and 0 reset tokens.
2025/04/30 11:06:22 Tracking 5 connection IDs and 0 reset tokens.
2025/04/30 11:06:24 Tracking 5 connection IDs and 0 reset tokens.
2025/04/30 11:06:24 Removing connection ID e0fad5b4 after it has been retired.
2025/04/30 11:06:24 Removing connection IDs [72331eea 4f1e2e6d bd690477 b58d5dfc] for a closed connection after it has been retired.
2025/04/30 11:06:26 Tracking 0 connection IDs and 0 reset tokens.