2025/04/30 17:11:16 Increased receive buffer size to 14336 kiB 2025/04/30 17:11:16 Increased send buffer size to 14336 kiB 2025/04/30 17:11:16 Setting DF for IPv4 and IPv6. 2025/04/30 17:11:16 Activating reading of ECN bits for IPv4 and IPv6. 2025/04/30 17:11:16 Activating reading of packet info for IPv4 and IPv6. 2025/04/30 17:11:16 server Listening for udp connections on [::]:443 2025/04/30 17:11:17 server Client offered version 0x57414954, sending Version Negotiation 2025/04/30 17:11:17 server Client offered version 0x57414954, sending Version Negotiation 2025/04/30 17:11:17 server Client offered version 0x57414954, sending Version Negotiation 2025/04/30 17:11:17 server <- Received Initial packet. 2025/04/30 17:11:17 Created qlog file: /logs/qlog/00cfeb65fd954af9.sqlog 2025/04/30 17:11:17 server Changing connection ID to e565314f. 2025/04/30 17:11:17 Adding connection IDs 00cfeb65fd954af9 and e565314f for a new connection. 2025/04/30 17:11:17 server <- Reading packet 0 (1200 bytes) for connection 00cfeb65fd954af9, Initial 2025/04/30 17:11:17 server Long Header{Type: Initial, DestConnectionID: 00cfeb65fd954af9, SrcConnectionID: 6b56e3a62923e5f9, Token: (empty), PacketNumber: 0, PacketNumberLen: 4, Length: 1174, Version: v1} 2025/04/30 17:11:17 server <- &wire.CryptoFrame{Offset: 0, Data length: 305, Offset + Data length: 305} 2025/04/30 17:11:17 server Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:17 server Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:17 server Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:17 server Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: (empty), InitialSourceConnectionID: 6b56e3a62923e5f9, InitialMaxStreamDataBidiLocal: 16777216, InitialMaxStreamDataBidiRemote: 16777216, InitialMaxStreamDataUni: 16777216, InitialMaxData: 1048576, MaxBidiStreamNum: 128, MaxUniStreamNum: 128, MaxIdleTimeout: 2m0s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 8} 2025/04/30 17:11:17 Adding connection ID 5fe201f8. 2025/04/30 17:11:17 Adding connection ID d0335e0f. 2025/04/30 17:11:17 Adding connection ID fa3a1236. 2025/04/30 17:11:17 Adding connection ID 41aff751. 2025/04/30 17:11:17 Adding connection ID ebe3c92a. 2025/04/30 17:11:17 server -> Sending coalesced packet (2 parts, 1280 bytes) for connection 00cfeb65fd954af9 2025/04/30 17:11:17 server Long Header{Type: Initial, DestConnectionID: 6b56e3a62923e5f9, SrcConnectionID: e565314f, Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 370, Version: v1} 2025/04/30 17:11:17 server -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s} 2025/04/30 17:11:17 server -> &wire.CryptoFrame{Offset: 0, Data length: 123, Offset + Data length: 123} 2025/04/30 17:11:17 server Long Header{Type: Handshake, DestConnectionID: 6b56e3a62923e5f9, SrcConnectionID: e565314f, PacketNumber: 0, PacketNumberLen: 2, Length: 720, Version: v1} 2025/04/30 17:11:17 server -> &wire.CryptoFrame{Offset: 0, Data length: 698, Offset + Data length: 698} 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: d0335e0f, StatelessResetToken: 0xdba332a137f140d689141975d6c7a183} 2025/04/30 17:11:17 server -> &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: fa3a1236, StatelessResetToken: 0x34f8c3bc43207d71bef8a367346538ab} 2025/04/30 17:11:17 server -> &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 5fe201f8, StatelessResetToken: 0x4564d50adae85edcdd85bcaa19d95971} 2025/04/30 17:11:17 server -> &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: 41aff751, StatelessResetToken: 0xdc71ee6394d7a2a2c73f4bf86a6ead48} 2025/04/30 17:11:17 server -> &wire.NewConnectionIDFrame{SequenceNumber: 5, RetirePriorTo: 0, ConnectionID: ebe3c92a, StatelessResetToken: 0x3503692ef5c794e45c05fef74c221445} 2025/04/30 17:11:17 server <- Reading packet 0 (80 bytes) for connection e565314f, Handshake 2025/04/30 17:11:17 server Long Header{Type: Handshake, DestConnectionID: e565314f, SrcConnectionID: 6b56e3a62923e5f9, PacketNumber: 0, PacketNumberLen: 4, Length: 59, Version: v1} 2025/04/30 17:11:17 server Dropping Initial keys. 2025/04/30 17:11:17 server <- &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36} 2025/04/30 17:11:17 server Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:17 Retiring connection ID 00cfeb65fd954af9 in 5s. 2025/04/30 17:11:17 server Dropping Handshake keys. 2025/04/30 17:11:17 server -> Sending packet 1 (256 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.CryptoFrame{Offset: 0, Data length: 135, Offset + Data length: 135} 2025/04/30 17:11:17 server -> &wire.NewTokenFrame{Token: 0xac4693837afe88c02fd0077deec6ba59b6351dc10ad79b13d0d23d672d73305813f33004fdae20c083fc1a724f6189d0fa2ba7bf9ecc21ce5fd4d4cff2ab3583d32eb12280047184bd3f3284dadddf4f32fcff7b1a7b} 2025/04/30 17:11:17 server -> &wire.HandshakeDoneFrame{} 2025/04/30 17:11:17 server Dropping %!s(logging.PacketType=0) packet (1200 bytes) because we already dropped the keys. 2025/04/30 17:11:17 server Dropping %!s(logging.PacketType=1) packet (47 bytes) because we already dropped the keys. 2025/04/30 17:11:17 server <- Reading packet 0 (46 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 0, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17} 2025/04/30 17:11:17 server Queueing ACK because the first packet should be acknowledged. 2025/04/30 17:11:17 server -> Sending packet 2 (32 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 62.036µs} 2025/04/30 17:11:17 Received request: GET /dxqizuhtxb 2025/04/30 17:11:17 server -> Sending packet 3 (1280 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1251, Offset + Data length: 1251} 2025/04/30 17:11:17 server -> Sending packet 4 (1280 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1251, Data length: 1249, Offset + Data length: 2500} 2025/04/30 17:11:17 server -> Sending packet 5 (1280 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2500, Data length: 1249, Offset + Data length: 3749} 2025/04/30 17:11:17 server -> Sending packet 6 (1280 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3749, Data length: 1249, Offset + Data length: 4998} 2025/04/30 17:11:17 server -> Sending packet 7 (153 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4998, Data length: 122, Offset + Data length: 5120} 2025/04/30 17:11:17 server -> Sending packet 8 (31 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: 6b56e3a62923e5f9, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 5120, Data length: 0, Offset + Data length: 5120} 2025/04/30 17:11:17 server <- Reading packet 1 (31 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 1, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 25.208ms} 2025/04/30 17:11:17 server newly acked packets (1): [0] 2025/04/30 17:11:17 server updated RTT: 56.882241ms (σ: 28.44112ms) 2025/04/30 17:11:17 server <- Reading packet 2 (53 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 2, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: c4ee3b4ef57bae76, StatelessResetToken: 0xcf0765620bd5e9a78cce6cb941334eb9} 2025/04/30 17:11:17 server Setting ACK timer to max ack delay: 25ms 2025/04/30 17:11:17 server <- Reading packet 3 (53 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 3, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: f36d8264c179f2eb, StatelessResetToken: 0x6a4a712b26db3e2301675831f0d03f9d} 2025/04/30 17:11:17 server Queueing ACK because packet 2 packets were received after the last ACK (using initial threshold: 2). 2025/04/30 17:11:17 server -> Sending packet 9 (34 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:17 server Short Header{DestConnectionID: c4ee3b4ef57bae76, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 84.758µs} 2025/04/30 17:11:17 server -> &wire.RetireConnectionIDFrame{SequenceNumber: 0} 2025/04/30 17:11:17 server <- Reading packet 4 (30 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 4, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 128µs} 2025/04/30 17:11:17 server newly acked packets (2): [1 3] 2025/04/30 17:11:17 server updated RTT: 53.738ms (σ: 27.618ms) 2025/04/30 17:11:17 server Disabling ECN. ECN-marked packet acknowledged, but no ECN counts on ACK frame. 2025/04/30 17:11:17 server <- Reading packet 5 (30 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 5, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 96µs} 2025/04/30 17:11:17 server newly acked packets (2): [4 5] 2025/04/30 17:11:17 server updated RTT: 51.232ms (σ: 25.723ms) 2025/04/30 17:11:17 server <- Reading packet 6 (30 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 6, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.AckFrame{LargestAcked: 8, LowestAcked: 0, DelayTime: 104µs} 2025/04/30 17:11:17 server newly acked packets (3): [6 7 8] 2025/04/30 17:11:17 server updated RTT: 49.204ms (σ: 23.347ms) 2025/04/30 17:11:17 server -> Sending packet 10 (30 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: Not-ECT) 2025/04/30 17:11:17 server Short Header{DestConnectionID: c4ee3b4ef57bae76, PacketNumber: 10, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.MaxStreamsFrame{Type: bidi, MaxStreamNum: 101} 2025/04/30 17:11:17 server <- Reading packet 7 (53 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 7, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: 1183b1d04cf9bcb7, StatelessResetToken: 0xa6d80daf947b231ba43290b99651f39a} 2025/04/30 17:11:17 server Setting ACK timer to max ack delay: 25ms 2025/04/30 17:11:17 server <- Reading packet 8 (30 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:17 server Short Header{DestConnectionID: e565314f, PacketNumber: 8, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:17 server <- &wire.AckFrame{LargestAcked: 10, LowestAcked: 0, DelayTime: 88µs} 2025/04/30 17:11:17 server newly acked packets (2): [9 10] 2025/04/30 17:11:17 server updated RTT: 46.876ms (σ: 22.165ms) 2025/04/30 17:11:17 server Canceling loss detection timer. 2025/04/30 17:11:17 server Ignoring all packets below 4. 2025/04/30 17:11:17 server Sending ACK because the ACK timer expired. 2025/04/30 17:11:17 server -> Sending packet 11 (33 bytes) for connection 00cfeb65fd954af9, 1-RTT (ECN: Not-ECT) 2025/04/30 17:11:17 server Short Header{DestConnectionID: c4ee3b4ef57bae76, PacketNumber: 11, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:17 server -> &wire.AckFrame{LargestAcked: 8, LowestAcked: 4, DelayTime: 20.178942ms} 2025/04/30 17:11:18 server <- Reading packet 9 (29 bytes) for connection e565314f, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: e565314f, PacketNumber: 9, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.ConnectionCloseFrame{IsApplicationError:false, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""} 2025/04/30 17:11:18 server Closing connection with error: NO_ERROR (remote) 2025/04/30 17:11:18 Replacing connection for connection IDs [e565314f 5fe201f8 d0335e0f fa3a1236 41aff751 ebe3c92a] with a closed connection. 2025/04/30 17:11:18 Error accepting stream: NO_ERROR (remote) 2025/04/30 17:11:18 server Connection 00cfeb65fd954af9 closed. 2025/04/30 17:11:18 server <- Received Initial packet. 2025/04/30 17:11:18 Created qlog file: /logs/qlog/aac9bc4dbdea8858.sqlog 2025/04/30 17:11:18 server Changing connection ID to 57bbf43e. 2025/04/30 17:11:18 Adding connection IDs aac9bc4dbdea8858 and 57bbf43e for a new connection. 2025/04/30 17:11:18 server <- Reading packet 0 (1200 bytes) for connection aac9bc4dbdea8858, Initial 2025/04/30 17:11:18 server Long Header{Type: Initial, DestConnectionID: aac9bc4dbdea8858, SrcConnectionID: 881e594476fa2797, Token: 0xac4693837afe88c02fd0077deec6ba59b6351dc10ad79b13d0d23d672d73305813f33004fdae20c083fc1a724f6189d0fa2ba7bf9ecc21ce5fd4d4cff2ab3583d32eb12280047184bd3f3284dadddf4f32fcff7b1a7b, PacketNumber: 0, PacketNumberLen: 4, Length: 1087, Version: v1} 2025/04/30 17:11:18 server <- &wire.CryptoFrame{Offset: 0, Data length: 305, Offset + Data length: 305} 2025/04/30 17:11:18 server Installed Handshake Write keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:18 server Installed Handshake Read keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:18 server Installed 1-RTT Write keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:18 server Processed Transport Parameters: &wire.TransportParameters{OriginalDestinationConnectionID: (empty), InitialSourceConnectionID: 881e594476fa2797, InitialMaxStreamDataBidiLocal: 16777216, InitialMaxStreamDataBidiRemote: 16777216, InitialMaxStreamDataUni: 16777216, InitialMaxData: 1048576, MaxBidiStreamNum: 128, MaxUniStreamNum: 128, MaxIdleTimeout: 2m0s, AckDelayExponent: 3, MaxAckDelay: 25ms, ActiveConnectionIDLimit: 8} 2025/04/30 17:11:18 Adding connection ID 0038cf73. 2025/04/30 17:11:18 Adding connection ID 7b479775. 2025/04/30 17:11:18 Adding connection ID 33ba3274. 2025/04/30 17:11:18 Adding connection ID 0661df07. 2025/04/30 17:11:18 Adding connection ID 680ff0ac. 2025/04/30 17:11:18 server -> Sending coalesced packet (2 parts, 1280 bytes) for connection aac9bc4dbdea8858 2025/04/30 17:11:18 server Long Header{Type: Initial, DestConnectionID: 881e594476fa2797, SrcConnectionID: 57bbf43e, Token: (empty), PacketNumber: 0, PacketNumberLen: 2, Length: 367, Version: v1} 2025/04/30 17:11:18 server -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 0s} 2025/04/30 17:11:18 server -> &wire.CryptoFrame{Offset: 0, Data length: 123, Offset + Data length: 123} 2025/04/30 17:11:18 server Long Header{Type: Handshake, DestConnectionID: 881e594476fa2797, SrcConnectionID: 57bbf43e, PacketNumber: 0, PacketNumberLen: 2, Length: 723, Version: v1} 2025/04/30 17:11:18 server -> &wire.CryptoFrame{Offset: 0, Data length: 701, Offset + Data length: 701} 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 0, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 7b479775, StatelessResetToken: 0x37c97770c65f7a4ebd51ff1777c8842f} 2025/04/30 17:11:18 server -> &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 0038cf73, StatelessResetToken: 0xc6095fa7d4e5db91de2ca682d8aab91e} 2025/04/30 17:11:18 server -> &wire.NewConnectionIDFrame{SequenceNumber: 5, RetirePriorTo: 0, ConnectionID: 680ff0ac, StatelessResetToken: 0x99eaeb81b874f1cf62ecf102afc63741} 2025/04/30 17:11:18 server -> &wire.NewConnectionIDFrame{SequenceNumber: 4, RetirePriorTo: 0, ConnectionID: 0661df07, StatelessResetToken: 0x3568434f0f7eaff3bb4f6f721d0cab28} 2025/04/30 17:11:18 server -> &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: 33ba3274, StatelessResetToken: 0xc9425944155731db8965de5ef872cf5d} 2025/04/30 17:11:18 server <- Reading packet 0 (80 bytes) for connection 57bbf43e, Handshake 2025/04/30 17:11:18 server Long Header{Type: Handshake, DestConnectionID: 57bbf43e, SrcConnectionID: 881e594476fa2797, PacketNumber: 0, PacketNumberLen: 4, Length: 59, Version: v1} 2025/04/30 17:11:18 server Dropping Initial keys. 2025/04/30 17:11:18 server <- &wire.CryptoFrame{Offset: 0, Data length: 36, Offset + Data length: 36} 2025/04/30 17:11:18 server Installed 1-RTT Read keys (using TLS_AES_128_GCM_SHA256) 2025/04/30 17:11:18 Retiring connection ID aac9bc4dbdea8858 in 5s. 2025/04/30 17:11:18 server Dropping Handshake keys. 2025/04/30 17:11:18 server -> Sending packet 1 (256 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 1, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.HandshakeDoneFrame{} 2025/04/30 17:11:18 server -> &wire.CryptoFrame{Offset: 0, Data length: 135, Offset + Data length: 135} 2025/04/30 17:11:18 server -> &wire.NewTokenFrame{Token: 0x96af628cbd5e882e99f3cce70dcbb6df8a2663010661985cefc0138f61d9e0b9eabe7e675bf3b172d3c779e5af9c1768165a600a9ab8fe29bf06ea279147282537db007babb858bd38db1390b0c8633ed197462d0f9d} 2025/04/30 17:11:18 server Dropping %!s(logging.PacketType=0) packet (1200 bytes) because we already dropped the keys. 2025/04/30 17:11:18 server Dropping %!s(logging.PacketType=1) packet (47 bytes) because we already dropped the keys. 2025/04/30 17:11:18 server <- Reading packet 0 (46 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 0, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 0, Data length: 17, Offset + Data length: 17} 2025/04/30 17:11:18 server Queueing ACK because the first packet should be acknowledged. 2025/04/30 17:11:18 server -> Sending packet 2 (32 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 2, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 71.774µs} 2025/04/30 17:11:18 Received request: GET /trrwycyrqc 2025/04/30 17:11:18 server -> Sending packet 3 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 3, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 0, Data length: 1251, Offset + Data length: 1251} 2025/04/30 17:11:18 server -> Sending packet 4 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 4, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 1251, Data length: 1249, Offset + Data length: 2500} 2025/04/30 17:11:18 server -> Sending packet 5 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 5, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 2500, Data length: 1249, Offset + Data length: 3749} 2025/04/30 17:11:18 server -> Sending packet 6 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 6, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 3749, Data length: 1249, Offset + Data length: 4998} 2025/04/30 17:11:18 server -> Sending packet 7 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 7, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 4998, Data length: 1249, Offset + Data length: 6247} 2025/04/30 17:11:18 server -> Sending packet 8 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 8, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 6247, Data length: 1249, Offset + Data length: 7496} 2025/04/30 17:11:18 server -> Sending packet 9 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 9, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 7496, Data length: 1249, Offset + Data length: 8745} 2025/04/30 17:11:18 server -> Sending packet 10 (1280 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: ECT(0)) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 10, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 8745, Data length: 1249, Offset + Data length: 9994} 2025/04/30 17:11:18 server -> Sending packet 11 (277 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: Not-ECT) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 11, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: false, Offset: 9994, Data length: 246, Offset + Data length: 10240} 2025/04/30 17:11:18 server -> Sending packet 12 (31 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: Not-ECT) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 881e594476fa2797, PacketNumber: 12, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.StreamFrame{StreamID: 0, Fin: true, Offset: 10240, Data length: 0, Offset + Data length: 10240} 2025/04/30 17:11:18 server <- Reading packet 1 (31 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 1, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.AckFrame{LargestAcked: 0, LowestAcked: 0, DelayTime: 25.584ms} 2025/04/30 17:11:18 server newly acked packets (1): [0] 2025/04/30 17:11:18 server updated RTT: 57.317239ms (σ: 28.658619ms) 2025/04/30 17:11:18 server <- Reading packet 6 (53 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 6, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.NewConnectionIDFrame{SequenceNumber: 1, RetirePriorTo: 0, ConnectionID: 9217938a66656c04, StatelessResetToken: 0x202df1e93c9b704c0864b01719c4c1ee} 2025/04/30 17:11:18 server Queuing ACK because there's a new missing packet to report. 2025/04/30 17:11:18 server -> Sending packet 13 (36 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: Not-ECT) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 9217938a66656c04, PacketNumber: 13, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.AckFrame{LargestAcked: 6, LowestAcked: 0, AckRanges: {{Largest: 6, Smallest: 6}, {Largest: 1, Smallest: 0}}, DelayTime: 90.248µs} 2025/04/30 17:11:18 server -> &wire.RetireConnectionIDFrame{SequenceNumber: 0} 2025/04/30 17:11:18 server <- Reading packet 7 (53 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 7, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.NewConnectionIDFrame{SequenceNumber: 2, RetirePriorTo: 0, ConnectionID: 5e08cefd3b7b0674, StatelessResetToken: 0x6bacf4f4b45d67d97da1fd8232fc774e} 2025/04/30 17:11:18 server Setting ACK timer to max ack delay: 25ms 2025/04/30 17:11:18 server <- Reading packet 8 (30 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 8, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.AckFrame{LargestAcked: 3, LowestAcked: 0, DelayTime: 128µs} 2025/04/30 17:11:18 server newly acked packets (2): [1 3] 2025/04/30 17:11:18 server updated RTT: 54.128ms (σ: 27.87ms) 2025/04/30 17:11:18 server Disabling ECN. ECN-marked packet acknowledged, but no ECN counts on ACK frame. 2025/04/30 17:11:18 server <- Reading packet 9 (30 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 9, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.AckFrame{LargestAcked: 5, LowestAcked: 0, DelayTime: 104µs} 2025/04/30 17:11:18 server newly acked packets (2): [4 5] 2025/04/30 17:11:18 server updated RTT: 51.584ms (σ: 25.989ms) 2025/04/30 17:11:18 server <- Reading packet 10 (30 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 10, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.AckFrame{LargestAcked: 7, LowestAcked: 0, DelayTime: 128µs} 2025/04/30 17:11:18 server newly acked packets (2): [6 7] 2025/04/30 17:11:18 server updated RTT: 49.619ms (σ: 23.42ms) 2025/04/30 17:11:18 server <- Reading packet 11 (30 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 11, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.AckFrame{LargestAcked: 9, LowestAcked: 0, DelayTime: 128µs} 2025/04/30 17:11:18 server newly acked packets (2): [8 9] 2025/04/30 17:11:18 server updated RTT: 48.167ms (σ: 20.468ms) 2025/04/30 17:11:18 server <- Reading packet 12 (30 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 12, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.AckFrame{LargestAcked: 12, LowestAcked: 0, DelayTime: 112µs} 2025/04/30 17:11:18 server newly acked packets (3): [10 11 12] 2025/04/30 17:11:18 server updated RTT: 47.068ms (σ: 17.547ms) 2025/04/30 17:11:18 server -> Sending packet 14 (37 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: Not-ECT) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 9217938a66656c04, PacketNumber: 14, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.AckFrame{LargestAcked: 12, LowestAcked: 0, AckRanges: {{Largest: 12, Smallest: 6}, {Largest: 1, Smallest: 0}}, DelayTime: 49.593µs} 2025/04/30 17:11:18 server -> &wire.MaxStreamsFrame{Type: bidi, MaxStreamNum: 101} 2025/04/30 17:11:18 server <- Reading packet 13 (53 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 13, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.NewConnectionIDFrame{SequenceNumber: 3, RetirePriorTo: 0, ConnectionID: 96deb22835a14a6f, StatelessResetToken: 0xfd88e0b1af48453266dc6c450f191d91} 2025/04/30 17:11:18 server Setting ACK timer to max ack delay: 25ms 2025/04/30 17:11:18 server <- Reading packet 14 (30 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 14, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.AckFrame{LargestAcked: 14, LowestAcked: 4, DelayTime: 216µs} 2025/04/30 17:11:18 server newly acked packets (2): [13 14] 2025/04/30 17:11:18 server updated RTT: 45.03ms (σ: 17.234ms) 2025/04/30 17:11:18 server Canceling loss detection timer. 2025/04/30 17:11:18 server Ignoring all packets below 13. 2025/04/30 17:11:18 server Sending ACK because the ACK timer expired. 2025/04/30 17:11:18 server -> Sending packet 15 (33 bytes) for connection aac9bc4dbdea8858, 1-RTT (ECN: Not-ECT) 2025/04/30 17:11:18 server Short Header{DestConnectionID: 9217938a66656c04, PacketNumber: 15, PacketNumberLen: 2, KeyPhase: 0} 2025/04/30 17:11:18 server -> &wire.AckFrame{LargestAcked: 14, LowestAcked: 13, DelayTime: 16.228805ms} 2025/04/30 17:11:18 Tracking 14 connection IDs and 1 reset tokens. 2025/04/30 17:11:18 server <- Reading packet 15 (29 bytes) for connection 57bbf43e, 1-RTT 2025/04/30 17:11:18 server Short Header{DestConnectionID: 57bbf43e, PacketNumber: 15, PacketNumberLen: 4, KeyPhase: 0} 2025/04/30 17:11:18 server <- &wire.ConnectionCloseFrame{IsApplicationError:false, ErrorCode:0x0, FrameType:0x0, ReasonPhrase:""} 2025/04/30 17:11:18 server Closing connection with error: NO_ERROR (remote) 2025/04/30 17:11:18 Replacing connection for connection IDs [57bbf43e 0038cf73 7b479775 33ba3274 0661df07 680ff0ac] with a closed connection. 2025/04/30 17:11:18 Error accepting stream: NO_ERROR (remote) 2025/04/30 17:11:18 server Connection aac9bc4dbdea8858 closed. 2025/04/30 17:11:20 Tracking 14 connection IDs and 0 reset tokens. 2025/04/30 17:11:22 Tracking 14 connection IDs and 0 reset tokens. 2025/04/30 17:11:22 Removing connection ID 00cfeb65fd954af9 after it has been retired. 2025/04/30 17:11:23 Removing connection IDs [e565314f 5fe201f8 d0335e0f fa3a1236 41aff751 ebe3c92a] for a closed connection after it has been retired. 2025/04/30 17:11:23 Removing connection ID aac9bc4dbdea8858 after it has been retired. 2025/04/30 17:11:23 Removing connection IDs [57bbf43e 0038cf73 7b479775 33ba3274 0661df07 680ff0ac] for a closed connection after it has been retired. 2025/04/30 17:11:24 Tracking 0 connection IDs and 0 reset tokens.