2025-04-30 12:22:34,997 Generated random file: sqofabfidu of size: 5120
2025-04-30 12:22:34,997 Generated random file: rlegbqlxgc of size: 10240
2025-04-30 12:22:34,997 Requests: https://server4:443/sqofabfidu https://server4:443/rlegbqlxgc
2025-04-30 12:22:35,057 
2025-04-30 12:22:35,057 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_70g2ub_o/ TESTCASE_SERVER=resumption TESTCASE_CLIENT=resumption WWW=/tmp/www_itxs_dij/ DOWNLOADS=/tmp/download_6c4qpul0/ SERVER_LOGS=/tmp/logs_server_odxykvdy CLIENT_LOGS=/tmp/logs_client_a41ljkus SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=privateoctopus/picoquic:latest SERVER=ghcr.io/nginx/nginx-quic-qns:latest REQUESTS="https://server4:443/sqofabfidu https://server4:443/rlegbqlxgc"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 12:22:47,711  Container sim  Created
 Container client  Recreate
 Container server  Recreate
 Container client  Recreated
 Container server  Recreated
Attaching to client, server, sim
sim     | waiting 10s for server:443
client  | Setting up the simulation with setup.sh
server  | Setting up routes...
client  | Setting up routes...
server  | Actual changes:
server  | tx-checksumming: off
server  | 	tx-checksum-ip-generic: off
server  | 	tx-checksum-sctp: off
server  | tcp-segmentation-offload: off
server  | 	tx-tcp-segmentation: off [requested on]
server  | 	tx-tcp-ecn-segmentation: off [requested on]
server  | 	tx-tcp-mangleid-segmentation: off [requested on]
server  | 	tx-tcp6-segmentation: off [requested on]
server  | tx-udp-segmentation: off [requested on]
client  | Actual changes:
client  | tx-checksum-ip-generic: off
client  | tx-tcp-segmentation: off [not requested]
client  | tx-tcp-ecn-segmentation: off [not requested]
client  | tx-tcp-mangleid-segmentation: off [not requested]
client  | tx-tcp6-segmentation: off [not requested]
client  | tx-udp-segmentation: off [not requested]
client  | tx-checksum-sctp: off
server  | Endpoint's IPv4 address is 193.167.100.100
client  | Endpoint's IPv4 address is 193.167.0.100
server  | Endpoint's IPv6 address is fd00:cafe:cafe:100::100
client  | Endpoint's IPv6 address is fd00:cafe:cafe::100
server  | >>> Starting nginx server...
client  | Setup.sh completed
client  | Waiting for  the simulator to start
server  | nginx version: nginx/1.27.0 (9270:d1b8568f3042)
server  | built by gcc 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2) 
server  | built with OpenSSL 1.1.1 (compatible; BoringSSL) (running with BoringSSL)
server  | TLS SNI support enabled
server  | configure arguments: --prefix=/etc/nginx --build=9270:d1b8568f3042 --sbin-path=/usr/sbin/nginx --modules-path=/usr/lib/nginx/modules --conf-path=/etc/nginx/nginx.conf --error-log-path=/var/log/nginx/error.log --http-log-path=/var/log/nginx/access.log --pid-path=/run/nginx.pid --lock-path=/run/nginx.lock --http-client-body-temp-path=/var/cache/nginx/client_temp --http-proxy-temp-path=/var/cache/nginx/proxy_temp --http-fastcgi-temp-path=/var/cache/nginx/fastcgi_temp --http-uwsgi-temp-path=/var/cache/nginx/uwsgi_temp --http-scgi-temp-path=/var/cache/nginx/scgi_temp --user=nginx --group=nginx --with-compat --with-debug --with-http_ssl_module --with-http_v2_module --with-http_v3_module --with-cc=c++ --with-cc-opt='-I/boringssl/include -O0 -fno-common -fno-omit-frame-pointer -DNGX_QUIC_DRAFT_VERSION=29 -DNGX_HTTP_V3_HQ=1 -x c' --with-ld-opt='-L/boringssl/build/ssl -L/boringssl/build/crypto'
server  | >>> Parameters: 
server  | >>> Test case: resumption
server  | 2025/04/30 12:22:35 [debug] 20#0: bind() 0.0.0.0:443 #5 
server  | 2025/04/30 12:22:35 [debug] 20#0: bind() 0.0.0.0:443 #6 
server  | 2025/04/30 12:22:35 [debug] 20#0: bind() [::]:443 #7 
server  | 2025/04/30 12:22:35 [debug] 20#0: bind() [::]:443 #8 
server  | 2025/04/30 12:22:35 [debug] 20#0: add cleanup: 00005617F6084750
server  | 2025/04/30 12:22:35 [notice] 20#0: using the "epoll" event method
server  | 2025/04/30 12:22:35 [debug] 20#0: counter: 00007FBF1E338080, 1
server  | 2025/04/30 12:22:35 [notice] 20#0: nginx/1.27.0 (9270:d1b8568f3042)
server  | 2025/04/30 12:22:35 [notice] 20#0: built by gcc 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2) 
server  | 2025/04/30 12:22:35 [notice] 20#0: OS: Linux 6.11.0-1012-azure
server  | 2025/04/30 12:22:35 [notice] 20#0: getrlimit(RLIMIT_NOFILE): 1048576:1048576
client  | wait-for-it.sh: waiting 30 seconds for sim:57832
server  | 2025/04/30 12:22:35 [debug] 20#0: write: 9, 00007FFF407D5C70, 3, 0
server  | 2025/04/30 12:22:35 [debug] 20#0: setproctitle: "nginx: master process /usr/sbin/nginx -c /etc/nginx/nginx.conf"
server  | 2025/04/30 12:22:35 [notice] 20#0: start worker processes
server  | 2025/04/30 12:22:35 [debug] 20#0: channel 3:9
server  | 2025/04/30 12:22:35 [notice] 20#0: start worker process 21
server  | 2025/04/30 12:22:35 [debug] 20#0: sigsuspend
server  | 2025/04/30 12:22:35 [debug] 21#0: add cleanup: 00005617F60847D8
server  | 2025/04/30 12:22:35 [debug] 21#0: malloc: 00005617F60877D0:16
server  | 2025/04/30 12:22:35 [debug] 21#0: add cleanup: 00005617F60847F0
server  | 2025/04/30 12:22:35 [debug] 21#0: malloc: 00005617F6085AD0:16
server  | 2025/04/30 12:22:35 [debug] 21#0: notify eventfd: 11
server  | 2025/04/30 12:22:35 [debug] 21#0: testing the EPOLLRDHUP flag: success
server  | 2025/04/30 12:22:35 [debug] 21#0: malloc: 00005617F606D430:6144
server  | 2025/04/30 12:22:35 [debug] 21#0: malloc: 00007FBF1DCAA010:253952
server  | 2025/04/30 12:22:35 [debug] 21#0: malloc: 00005617F6089890:98304
server  | 2025/04/30 12:22:35 [debug] 21#0: malloc: 00005617F60A18A0:98304
server  | 2025/04/30 12:22:35 [debug] 21#0: epoll add event: fd:5 op:1 ev:00002001
server  | 2025/04/30 12:22:35 [debug] 21#0: epoll add event: fd:6 op:1 ev:00002001
server  | 2025/04/30 12:22:35 [debug] 21#0: epoll add event: fd:7 op:1 ev:00002001
server  | 2025/04/30 12:22:35 [debug] 21#0: epoll add event: fd:8 op:1 ev:00002001
server  | 2025/04/30 12:22:35 [debug] 21#0: epoll add event: fd:9 op:1 ev:00002001
server  | 2025/04/30 12:22:35 [debug] 21#0: setproctitle: "nginx: worker process"
server  | 2025/04/30 12:22:35 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:35 [debug] 21#0: epoll timer: -1
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
sim     | server:443 is available after 1.037257367s
server  | 2025/04/30 12:22:36 [debug] 21#0: posix_memalign: 00005617F6085B30:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: malloc: 00005617F60877F0:1207
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic recvmsg: 193.167.100.2:32890 fd:6 n:1207
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic run
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic packet rx dcid len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic packet rx scid len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic address validation token len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 sending version negotiation packet
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 sendmsg: 11 of 11
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 reusable connection: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 free: 00005617F60877F0
server  | 2025/04/30 12:22:36 [debug] 21#0: *1 free: 00005617F6085B30, unused: 24
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 806
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: -1
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: posix_memalign: 00005617F6085B30:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: malloc: 00005617F60877F0:1207
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic recvmsg: 193.167.100.2:32890 fd:6 n:1207
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic run
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic packet rx dcid len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic packet rx scid len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic address validation token len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 sending version negotiation packet
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 sendmsg: 11 of 11
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 reusable connection: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 free: 00005617F60877F0
server  | 2025/04/30 12:22:36 [debug] 21#0: *2 free: 00005617F6085B30, unused: 24
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: -1
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: posix_memalign: 00005617F6085B30:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: malloc: 00005617F60877F0:1207
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic recvmsg: 193.167.100.2:32890 fd:6 n:1207
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic run
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic packet rx dcid len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic packet rx scid len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic address validation token len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 sending version negotiation packet
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 sendmsg: 11 of 11
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 reusable connection: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 free: 00005617F60877F0
server  | 2025/04/30 12:22:36 [debug] 21#0: *3 free: 00005617F6085B30, unused: 24
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: -1
sim     | Using scenario: simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25
sim     | tcpdump: listening on eth0, link-type EN10MB (Ethernet), snapshot length 262144 bytes
sim     | tcpdump: listening on eth1, link-type EN10MB (Ethernet), snapshot length 262144 bytes
client  | wait-for-it.sh: sim:57832 is available after 1 seconds
client  | Starting picoquic client for test: resumption
client  | Starting picoquic client ...
client  | Parsing server name from first request: https://server4:443/sqofabfidu
client  | Server set to: server4
client  | Requests:  https://server4:443/sqofabfidu https://server4:443/rlegbqlxgc
client  | parsing <https://server4:443/sqofabfidu> as <sqofabfidu>
client  | parsing <https://server4:443/rlegbqlxgc> as <rlegbqlxgc>
client  | File1: -:/sqofabfidu
client  | File2: -:/rlegbqlxgc;
client  | rm: cannot remove '*.bin': No such file or directory
client  | /picoquic/picoquicdemo  -8 -L -l /logs/test_log.txt -q /logs/qlog -o /downloads -0 -d 180000 -a hq-interop -v 00000001 server4 443 -:/sqofabfidu
client  | Starting Picoquic (v1.1.26.1) connection to server = server4, port = 443
client  | No token file present. Will create one as <demo_token_store.bin>.
client  | Testing scenario: <-:/sqofabfidu>
client  | Max stream id bidir remote before start = 0 (0)
client  | Starting client connection. Version = 1, I-CID: dc8f76322d975354
client  | Max stream id bidir remote after start = -4 (0)
client  | Waiting for packets.
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: posix_memalign: 00005617F6085B30:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: malloc: 00005617F60877F0:1252
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic recvmsg: 193.167.0.100:58835 fd:6 n:1252
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic run
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx long flags:c2 version:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx init len:1226
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx dcid len:8 dc8f76322d975354
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx scid len:8 317831fef8061eee
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic address validation token len:0 
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 malloc: 00005617F606EC40:2448
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 malloc: 00005617F606F5E0:1528
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F6085D40:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_set_initial_secret
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:0 listening at sid:000000000000000225ef0e2467747e64e164aca6 nsock:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic cid seq:0 received id:8:317831fef8061eee:00000000000000000000000000000000
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60701E0:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 created addr:193.167.0.100:58835
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 set active tx:0 rx:0 valid:0 st:0 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60703F0:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:-1 listening at sid:dc8f76322d975354 nsock:2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 reusable connection: 1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic connection created
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx clearflags:c3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx number:124802 len:4
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet len:1252 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 status tx:0 rx:1252 valid:0 st:0 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token be1a6305a2ff1ae84c80bbbee1f2a3cd
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx init:124802 PING
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx init:124802 CRYPTO len:285 off:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL server name: "server4"
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL ALPN supported by client: hq-interop
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL ALPN selected: hq-interop
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_add_handshake_data
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic SSL_get_peer_quic_transport_params(): params_len:85
server  | 2025/04/30 12:22:36 [info] 21#0: *4 quic reserved transport param id:0x1ade, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:36 [info] 21#0: *4 quic unknown transport param id:0xff04de1b, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:36 [info] 21#0: *4 quic unknown transport param id:0x7158, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:36 [info] 21#0: *4 quic unknown transport param id:0x2ab2, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic transport parameters parsed ok
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp disable active migration: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp idle_timeout:180000
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp max_udp_payload_size:1440
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp max_data:1048576
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp max_stream_data_bidi_local:2097152
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp max_stream_data_bidi_remote:65635
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp max_stream_data_uni:65535
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp initial_max_streams_bidi:512
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp initial_max_streams_uni:512
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp ack_delay_exponent:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp max_ack_delay:10
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp active_connection_id_limit:8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic tp initial source_connection_id len:8 317831fef8061eee
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 malloc: 00005617F6064170:4096
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F6065180:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_set_write_secret() level:2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_add_handshake_data
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 malloc: 00005617F6066640:4096
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_set_write_secret() level:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_flush_flight()
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_set_read_secret() level:2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL_do_handshake: -1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL_get_error: 2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx init:124802 PADDING
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_ack_packet pn:124802 largest -1 fr:0 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet done rc:0 level:init decr:1 pn:124802 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 75000:503726
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 60000:488726
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: read:75000 close:60000
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 237
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic push handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60B9E00:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output init packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx init:0 ACK n:0 delay:0 124802
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx init:0 CRYPTO len:123 off:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx init bytes:135 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output hs packet max:1010 min:1010
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx hs:0 CRYPTO len:719 off:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx hs bytes:956 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:190
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503726
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer pto:997
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 997:429723
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: send:75000 pto:997 close:60000
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: 997
client  | Client port (AF=2): 54245.
client  | Negotiated ALPN: hq-interop
client  | Almost ready!
client  | 
client  | Connection established. Version = 1, I-CID: dc8f76322d975354, verified: 1
client  | Opening stream 0 to GET /sqofabfidu
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic recvmsg: fd:6 n:284
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic input handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx long flags:ec version:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx hs len:64
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx dcid len:20 000000000000000225ef0e2467747e64e164aca6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx scid len:8 317831fef8061eee
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx clearflags:e3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx number:0 len:4
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet len:284 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 status tx:1200 rx:1536 valid:0 st:0 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion ack recovery win:131054 ss:-1 if:1010
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:-1 closed nsock:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 429723
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer pto:963
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 963:429723
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 in handshake tx:1200 rx:1536 valid:1 st:0 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx hs:0 ACK n:0 delay:41 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_handle_ack_frame level:2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion ack recovery win:131054 ss:-1 if:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic updated largest received ack:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic rtt sample latest:34 min:34 avg:34 var:17
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 429723
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer unset
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx hs:0 CRYPTO len:36 off:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_set_read_secret() level:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_add_handshake_data
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_flush_flight()
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL_do_handshake: 1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL: TLSv1.3, cipher: "TLS_AES_128_GCM_SHA256 Kx=GENERIC Au=GENERIC Enc=AESGCM(128) Mac=AEAD"
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F3C8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer unset
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 schedule mtu:1440
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 100:428860
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic create sockets has:1 max:8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:1 listening at sid:00000000000000022e30dfed95ff3075e196f4aa nsock:2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token 1138f98f5f98e2476dc483621322207d
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:2 listening at sid:0000000000000002fd6c4e4d2550798ebe321817 nsock:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F6063210:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token 4383b4b0acd8b81f0a422f86520adcd6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:3 listening at sid:000000000000000259772dabe4195a65561c6e54 nsock:4
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F6063420:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token e9675e8a41783334be8df53eb7c6016d
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:4 listening at sid:0000000000000002351d5d0a69e11331b7b4249c nsock:5
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F6063630:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token c456f0e9519fe4d99488f982570231fe
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:5 listening at sid:000000000000000259662808077258f9b91ba5ad nsock:6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BA9C0:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token 7e73b2e851867ae229a9d687ec82e866
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:6 listening at sid:0000000000000002798c0f0e30510b10a527117c nsock:7
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BABD0:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token 26650b767dc562f717c0ce5787b6eb52
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:7 listening at sid:00000000000000028a0f72036b436fcbdcd15a1e nsock:8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BADE0:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stateless reset token 2546e08080b156144391ce411be71aad
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic init streams
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 http3 init
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 http3 init session
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BAFF0:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 add cleanup: 00005617F60633C8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 75000:503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 488726
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet done rc:0 level:hs decr:1 pn:0 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx short flags:4b
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx dcid len:20 000000000000000225ef0e2467747e64e164aca6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx number:0 len:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:0 NEW_CONNECTION_ID seq:1 retire:0 len:8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic cid seq:1 received id:8:7aa7a68998968dc9:2f98cc4558225beef3b4d007c70751ee
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:0 PADDING
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet done rc:0 level:app decr:1 pn:0 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: read:74966
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 34
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic push handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 ACK n:0 delay:0 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 CRYPTO len:572 off:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 HANDSHAKE DONE
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:1 retire:0 len:20
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:2 retire:0 len:20
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:3 retire:0 len:20
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:4 retire:0 len:20
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:5 retire:0 len:20
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:6 retire:0 len:20
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:7 retire:0 len:20
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx app bytes:862 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 888 of 888
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:888
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer pto:112
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 112:428872
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: send:74966 pto:112
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F3C8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F3C8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic key update
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: 100
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic recvmsg: fd:6 n:183
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic input handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx short flags:53
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx dcid len:20 000000000000000225ef0e2467747e64e164aca6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx number:1 len:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet len:183 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 status tx:2088 rx:1719 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:1 STREAM id:0x0 len:17 fin:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 is missing
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 create
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BB200:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BB410:16384 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 reusable connection: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 add cleanup: 00005617F60BB4D0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 post event 00005617F6089AD0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 flow control msd:17/65536 md:17/8585216
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:1 PADDING
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_ack_packet pn:1 largest 0 fr:0 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet done rc:0 level:app decr:1 pn:1 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: read:74966 pto:112
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F6089AD0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 delete posted event 00005617F6089AD0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 quic init stream
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http3 init request stream
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 add cleanup: 00005617F60BB540
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http wait request handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 recv buf:1024
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 quic stream id:0x0 recv len:17
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 flow update 17
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 reusable connection: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 posix_memalign: 00005617F60BF420:4096 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http process request line
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http request line: "GET /sqofabfidu"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http uri: "/sqofabfidu"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http args: ""
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http exten: ""
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 rewrite phase: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 test location: "/"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 using configuration "/"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http cl:-1 max:1048576
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 rewrite phase: 2
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 post rewrite phase: 3
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 generic phase: 4
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 generic phase: 5
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 access phase: 6
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 access phase: 7
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 post access phase: 8
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 generic phase: 9
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 generic phase: 10
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 content phase: 11
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 content phase: 12
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 content phase: 13
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http filename: "/www/sqofabfidu"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 add cleanup: 00005617F60C0158
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http static fd: 3
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http set discard body
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http output filter "/sqofabfidu?"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http copy filter: "/sqofabfidu?"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 malloc: 00005617F60C0430:5120
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 read: 3, 00005617F60C0430, 5120, 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http postpone filter "/sqofabfidu?" 00005617F60C0370
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 write new buf t:1 f:0 00005617F60C0430, pos 00005617F60C0430, size: 5120 file: 0, size: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http write filter: l:1 f:0 s:5120
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http write filter limit 2097152
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 malloc: 00005617F60C1840:4096
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 malloc: 00005617F60C2850:4096
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 quic send_chain sent:5120
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 flush limit:1048576
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 flush len:5120 last:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http write filter 0000000000000000
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http copy filter: 0 "/sqofabfidu?"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http finalize request: 0, "/sqofabfidu?" a:1, c:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http request count:1 blk:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http close request
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 http log handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 posix_memalign: 00005617F60C3860:4096 @16
server  | 193.167.0.100 - - [30/Apr/2025:12:22:36 +0000] "GET /sqofabfidu" 200 5120 "-" "-"
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 run cleanup: 00005617F60C0158
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 file cleanup: fd:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 free: 00005617F60C0430
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 free: 00005617F60BF420, unused: 48
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 free: 00005617F60C3860, unused: 3949
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 close http connection: 6
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 reusable connection: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 run cleanup: 00005617F60BB540
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 75000:503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 run cleanup: 00005617F60BB4D0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 cleanup
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 send shutdown
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 flush limit:1043456
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BF420:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 flush len:0 last:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *5 free: 00005617F60BB410, unused: 14952
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic push handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:1 ACK n:0 delay:0 1-0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic split frame now:5125 need:1169 shrink:3956
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BF630:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:1 STREAM id:0x0 off:0 len:1164
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx app bytes:1174 need_ack:1 number:1 encoded nl:1 trunc:0x1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:888
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:888
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:2088
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic split frame now:3962 need:1174 shrink:2788
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:2 STREAM id:0x0 off:1164 len:1168
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx app bytes:1174 need_ack:1 number:2 encoded nl:1 trunc:0x2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:2088
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:2088
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:3288
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic split frame now:2794 need:1174 shrink:1620
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 posix_memalign: 00005617F60BF840:512 @16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:3 STREAM id:0x0 off:2332 len:1168
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx app bytes:1174 need_ack:1 number:3 encoded nl:1 trunc:0x3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:3288
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:3288
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:4488
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic split frame now:1626 need:1174 shrink:452
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:4 STREAM id:0x0 off:3500 len:1168
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx app bytes:1174 need_ack:1 number:4 encoded nl:1 trunc:0x4
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:4488
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:4488
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:5688
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:5 STREAM id:0x0 off:4668 len:452
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:5 STREAM id:0x0 off:5120 len:0 fin:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx app bytes:463 need_ack:1 number:5 encoded nl:1 trunc:0x5
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 489 of 489
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:5688
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:5688
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:6177
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 428872
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer pto:112
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 112:428872
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: send:74966 pto:112
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: 100
client  | Stream 0 ended after 5120 bytes
client  | All done, Closing the connection.
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic recvmsg: fd:6 n:55
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic input handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx short flags:75
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx dcid len:20 000000000000000225ef0e2467747e64e164aca6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx clearflags:60
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx number:2 len:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet len:55 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 status tx:7377 rx:1774 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:2 ACK n:0 delay:2 2-0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion slow start win:131942 ss:-1 if:5289
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_drop_ack_ranges pn:0 largest:1 fr:1 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion slow start win:133142 ss:-1 if:4089
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_drop_ack_ranges pn:1 largest:1 fr:0 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 ack len:1164 fin:0 unacked:3956
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion slow start win:134342 ss:-1 if:2889
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 ack len:1168 fin:0 unacked:2788
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic updated largest received ack:2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic rtt sample latest:34 min:34 avg:34 var:13
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 428872
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer pto:62
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 62:428856
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:2 PADDING
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_ack_packet pn:2 largest -1 fr:0 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet done rc:0 level:app decr:1 pn:2 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503794
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: read:74932 pto:62
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 34
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic push handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: read:74932 pto:62
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: 62
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic recvmsg: fd:6 n:55
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic input handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx short flags:6d
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx dcid len:20 000000000000000225ef0e2467747e64e164aca6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx clearflags:60
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx number:3 len:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet len:55 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 status tx:7377 rx:1829 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:3 ACK n:0 delay:4 4-0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion slow start win:135542 ss:-1 if:1689
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 ack len:1168 fin:0 unacked:1620
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion slow start win:136742 ss:-1 if:489
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 ack len:1168 fin:0 unacked:452
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic updated largest received ack:4
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic rtt sample latest:36 min:34 avg:34 var:10
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 428856
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer pto:48
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 48:428844
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:3 PADDING
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_ack_packet pn:3 largest 2 fr:0 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet done rc:0 level:app decr:1 pn:3 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503796
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: read:74930 pto:48
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 2
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic push handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: read:74930 pto:48
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: 48
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:36 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic recvmsg: fd:6 n:46
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic input handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx short flags:61
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx dcid len:20 000000000000000225ef0e2467747e64e164aca6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx clearflags:60
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet rx number:4 len:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet len:46 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic path seq:0 status tx:7377 rx:1875 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:4 ACK n:0 delay:6 5-0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion slow start win:137231 ss:-1 if:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 ack len:452 fin:0 unacked:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 ack len:0 fin:1 unacked:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic stream id:0x0 close
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 reusable connection: 1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 update posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic updated largest received ack:5
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic rtt sample latest:36 min:34 avg:34 var:8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 428844
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer unset
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame rx app:4 CONNECTION_CLOSE_APP err:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 post event 00005617F606F308
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_ack_packet pn:4 largest 3 fr:1 nranges:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet done rc:0 level:app decr:1 pn:4 perr:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503796
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: draining read:74930
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic push handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic frame tx app:6 MAX_STREAMS limit:129 bidi:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic packet tx app bytes:3 need_ack:1 number:6 encoded nl:1 trunc:0x6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 sendmsg: 29 of 29
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic congestion send if:29
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer: 6, old: 503726, new: 503796
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic lost timer pto:76
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 76:428872
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic state: draining send:74930 pto:76
server  | 2025/04/30 12:22:36 [debug] 21#0: posted event 00005617F606F308
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 delete posted event 00005617F606F308
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic close handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic close initiated rc:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic close immediate term:0 drain:1 error:1 ""
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer add: 6: 228:429024
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 428872
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 428860
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: 228
server  | 2025/04/30 12:22:36 [debug] 21#0: timer delta: 229
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 429024
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic close handler
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic close resumed rc:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:0 closed nsock:7
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:1 closed nsock:6
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:2 closed nsock:5
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:3 closed nsock:4
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:4 closed nsock:3
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:5 closed nsock:2
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:6 closed nsock:1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic socket seq:7 closed nsock:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic close completed
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 quic ngx_quic_send_alert() level:app alert:0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 SSL_shutdown: 1
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: 6: 503726
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 reusable connection: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 run cleanup: 00005617F60633C8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 event timer del: -1: 503760
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60C2850
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60C1840
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6066640
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6064170
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F606F5E0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F606EC40
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60877F0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6085B30, unused: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6085D40, unused: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60701E0, unused: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60703F0, unused: 16
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6065180, unused: 32
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60B9E00, unused: 72
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6063210, unused: 48
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6063420, unused: 8
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F6063630, unused: 56
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BA9C0, unused: 40
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BABD0, unused: 56
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BADE0, unused: 32
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BAFF0, unused: 32
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BB200, unused: 0
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BF420, unused: 32
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BF630, unused: 32
server  | 2025/04/30 12:22:36 [debug] 21#0: *4 free: 00005617F60BF840, unused: 192
server  | 2025/04/30 12:22:36 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:36 [debug] 21#0: epoll timer: -1
client  | Received a request to close the connection.
client  | Address Discovery mode: 0 / 0 (0:0)
client  | Quic Bit was NOT greased by the client.
client  | Quic Bit was NOT greased by the server.
client  | ECN was not received.
client  | ECN was not acknowledged.
client  | Received 5120 bytes in 0.413470 seconds, 0.099064 Mbps.
client  | Sent 17 bytes in 0.413470 seconds, 0.000329 Mbps.
client  | max_data_local: 1048576
client  | max_stream_data_local: 2097152
client  | max_data_remote: 8585216
client  | max_stream_data_remote: 0
client  | ack_delay_remote: 1000 ... 4857
client  | max_ack_gap_remote: 2
client  | ack_delay_local: 25000 ... 25000
client  | max_ack_gap_local: 2
client  | max_mtu_sent: 1252
client  | max_mtu_received: 1200
client  | System call duration max: 25
client  | System call duration smoothed: 1
client  | System call duration deviation: 3
client  | Received ticket from server4 (hq-interop):
client  | ticket time = 1746015756701, kx = 17, suite = 1301, 282 ticket, 32 secret.
client  | lifetime = 300, age_add = d6e61b1e, 1 nonce, 256 ticket, 12 extensions.
client  | ticket extensions: 42(ED: ffffffff),
client  | 4 extra bytes at the end of the extensions
client  | Client exit with code = 0
client  | /picoquic/picoquicdemo  -8 -L -l /logs/test_log.txt -q /logs/qlog -o /downloads -0 -d 180000 -a hq-interop -v 00000001 server4 443 -:/rlegbqlxgc;
client  | Starting Picoquic (v1.1.26.1) connection to server = server4, port = 443
client  | Testing scenario: <-:/rlegbqlxgc;>
client  | Max stream id bidir remote before start = 0 (0)
client  | Starting client connection. Version = 1, I-CID: c4f5a29d5f65e24a
client  | Max stream id bidir remote after start = 508 (128)
client  | Max stream id bidir remote after 0rtt = 508 (128)
client  | Opening stream 0 to GET /rlegbqlxgc
client  | Waiting for packets.
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: posix_memalign: 00005617F6063210:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: malloc: 00005617F60877F0:1252
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: 193.167.0.100:33995 fd:6 n:1252
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic run
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx long flags:c3 version:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx init len:617
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:8 c4f5a29d5f65e24a
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx scid len:8 39f2b8688d9b9f90
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic address validation token len:0 
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F606EC40:2448
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F606F5E0:1528
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60B9E00:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_set_initial_secret
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:0 listening at sid:0000000000000002dc99c541c517444c2409c8a6 nsock:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic cid seq:0 received id:8:39f2b8688d9b9f90:00000000000000000000000000000000
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6065180:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 created addr:193.167.0.100:33995
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 set active tx:0 rx:0 valid:0 st:0 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60703F0:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:-1 listening at sid:c4f5a29d5f65e24a nsock:2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 reusable connection: 1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic connection created
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:c3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:118593 len:4
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:1252 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:0 rx:1252 valid:0 st:0 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token 1690c80868e5da8829b9763f1bd59ca9
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx init:118593 PING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx init:118593 CRYPTO len:592 off:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL server name: "server4"
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL ALPN supported by client: hq-interop
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL ALPN selected: hq-interop
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_add_handshake_data
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic SSL_get_peer_quic_transport_params(): params_len:85
server  | 2025/04/30 12:22:37 [info] 21#0: *6 quic reserved transport param id:0x17f6, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:37 [info] 21#0: *6 quic unknown transport param id:0xff04de1b, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:37 [info] 21#0: *6 quic unknown transport param id:0x7158, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:37 [info] 21#0: *6 quic unknown transport param id:0x2ab2, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic transport parameters parsed ok
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp disable active migration: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp idle_timeout:180000
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp max_udp_payload_size:1440
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp max_data:1048576
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp max_stream_data_bidi_local:2097152
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp max_stream_data_bidi_remote:65635
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp max_stream_data_uni:65535
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp initial_max_streams_bidi:512
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp initial_max_streams_uni:512
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp ack_delay_exponent:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp max_ack_delay:10
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp active_connection_id_limit:8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic tp initial source_connection_id len:8 39f2b8688d9b9f90
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F6066640:4096
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60701E0:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_set_write_secret() level:2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_add_handshake_data
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F60BA9C0:4096
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_set_write_secret() level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_add_handshake_data
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F60BB9D0:4096
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6085D40:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_flush_flight()
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_set_read_secret() level:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_set_read_secret() level:2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL_do_handshake: 1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic init streams
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 http3 init
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 http3 init session
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6085B30:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 add cleanup: 00005617F6085E40
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 75000:504139
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:118593 largest -1 fr:0 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:init decr:1 pn:118593 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx long flags:d2 version:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx early len:584
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:8 c4f5a29d5f65e24a
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx scid len:8 39f2b8688d9b9f90
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:d3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:0 len:4
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx early:0 STREAM id:0x0 len:17 fin:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 is missing
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 create
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60647E0:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60BC9E0:16384 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 reusable connection: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 add cleanup: 00005617F60BCAA0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 post event 00005617F6089AD0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 flow control msd:17/65536 md:17/8585216
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F60C09F0:4096
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx early:0 PADDING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:early decr:1 pn:0 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 75000:504139
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:75000
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 114
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F6089AD0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 delete posted event 00005617F6089AD0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 quic init stream
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http3 init request stream
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 add cleanup: 00005617F60BCB10
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 504139
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http wait request handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 recv buf:1024
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 quic stream id:0x0 recv len:17
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 flow update 17
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 reusable connection: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 posix_memalign: 00005617F60C1A00:4096 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http process request line
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http request line: "GET /rlegbqlxgc"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http uri: "/rlegbqlxgc"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http args: ""
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http exten: ""
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 rewrite phase: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 test location: "/"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 using configuration "/"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http cl:-1 max:1048576
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 rewrite phase: 2
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 post rewrite phase: 3
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 generic phase: 4
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 generic phase: 5
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 access phase: 6
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 access phase: 7
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 post access phase: 8
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 generic phase: 9
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 generic phase: 10
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 content phase: 11
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 content phase: 12
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 content phase: 13
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http filename: "/www/rlegbqlxgc"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 add cleanup: 00005617F60C2738
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http static fd: 3
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http set discard body
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http output filter "/rlegbqlxgc?"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http copy filter: "/rlegbqlxgc?"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 malloc: 00005617F60C2A10:10240
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 read: 3, 00005617F60C2A10, 10240, 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http postpone filter "/rlegbqlxgc?" 00005617F60C2950
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 write new buf t:1 f:0 00005617F60C2A10, pos 00005617F60C2A10, size: 10240 file: 0, size: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http write filter: l:1 f:0 s:10240
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http write filter limit 2097152
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F60C5220:4096
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F60C6230:4096
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 malloc: 00005617F60C7240:4096
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 quic send_chain sent:10240
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 flush limit:1048576
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60649F0:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 flush len:10240 last:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http write filter 0000000000000000
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http copy filter: 0 "/rlegbqlxgc?"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http finalize request: 0, "/rlegbqlxgc?" a:1, c:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http request count:1 blk:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http close request
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 http log handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 posix_memalign: 00005617F60C8250:4096 @16
server  | 193.167.0.100 - - [30/Apr/2025:12:22:37 +0000] "GET /rlegbqlxgc" 200 10240 "-" "-"
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 run cleanup: 00005617F60C2738
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 file cleanup: fd:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 free: 00005617F60C2A10
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 free: 00005617F60C1A00, unused: 48
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 free: 00005617F60C8250, unused: 3949
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 close http connection: 6
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 reusable connection: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 run cleanup: 00005617F60BCB10
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 75000:504139
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 run cleanup: 00005617F60BCAA0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 cleanup
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 send shutdown
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 flush limit:1038336
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 flush len:0 last:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *7 free: 00005617F60BC9E0, unused: 14952
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output init packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx init:0 ACK n:0 delay:0 118593
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx init:0 CRYPTO len:129 off:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx init bytes:141 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output hs packet max:1004 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx hs:0 CRYPTO len:169 off:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx hs bytes:173 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6064C00:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:777 min:777
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:0 ACK n:0 delay:0 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:0 CRYPTO len:572 off:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:10245 need:170 shrink:10075
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:0 STREAM id:0x0 off:0 len:165
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:751 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:196
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:423
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:10081 need:1174 shrink:8907
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6064E10:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:1 STREAM id:0x0 off:165 len:1168
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:1 encoded nl:1 trunc:0x1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:2400
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:8913 need:1174 shrink:7739
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:2 STREAM id:0x0 off:1333 len:1168
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:2 encoded nl:1 trunc:0x2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:2400
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:2400
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:3600
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:156 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:7745 need:130 shrink:7615
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60C1A00:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:3 STREAM id:0x0 off:2501 len:124
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:130 need_ack:1 number:3 encoded nl:1 trunc:0x3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 156 of 156
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:3600
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:3600
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:3756
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:0 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504139
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:997
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 997:430136
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: send:75000 pto:997
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 997
client  | Client port (AF=2): 52100.
client  | The session was properly resumed!
client  | Zero RTT data is accepted!
client  | Negotiated ALPN: hq-interop
client  | Almost ready!
client  | 
client  | Connection established. Version = 1, I-CID: c4f5a29d5f65e24a, verified: 1
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: fd:6 n:284
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic input handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx long flags:e7 version:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx hs len:64
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx scid len:8 39f2b8688d9b9f90
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:e3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:0 len:4
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:284 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:3756 rx:1536 valid:0 st:0 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion ack recovery win:131054 ss:-1 if:3560
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:-1 closed nsock:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 430136
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:963
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 963:430136
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 in handshake tx:3756 rx:1536 valid:1 st:0 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx hs:0 ACK n:0 delay:44 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_handle_ack_frame level:2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion ack recovery win:131054 ss:-1 if:3333
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic updated largest received ack:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic rtt sample latest:34 min:34 avg:34 var:17
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 430136
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:68
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 68:429241
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx hs:0 CRYPTO len:36 off:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_set_read_secret() level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL_do_handshake: 1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL: TLSv1.3, cipher: "TLS_AES_128_GCM_SHA256 Kx=GENERIC Au=GENERIC Enc=AESGCM(128) Mac=AEAD"
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL reused session
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F3C8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429241
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:78
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 78:429251
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 schedule mtu:1440
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 100:429273
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic create sockets has:1 max:8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:1 listening at sid:00000000000000025de469893b9be409a55752f2 nsock:2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token 1a3f6461704242a83acf9ec01509d217
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:2 listening at sid:0000000000000002099b3404b4a87576d820e10c nsock:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token c102d4aad2000ddb1799f75b4c5e33b2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6064170:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:3 listening at sid:0000000000000002daf36319abb4b15c40e49e9e nsock:4
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token f8af5bd892b06374fdc40bbf325e26d5
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6064380:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:4 listening at sid:0000000000000002f52b73177121a62a2b89d79b nsock:5
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token 9bfe378b41380c943a2eb236b8d9bba2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F6064590:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:5 listening at sid:0000000000000002322e01d28714be15a704adc8 nsock:6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token 6c67712718ced44b7b0bfb80db47bf03
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60C1C10:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:6 listening at sid:0000000000000002990c3b144a0c58d01421efc1 nsock:7
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token e7efe47655a54572cd1e8b3fd294d8c9
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60C1E20:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:7 listening at sid:000000000000000289e5b92012a6a7357ee62953 nsock:8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stateless reset token 13b54eadc81217f2fc6b471d8128bcd5
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:hs decr:1 pn:0 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx short flags:67
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:1 len:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:1 NEW_CONNECTION_ID seq:1 retire:0 len:8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60C2030:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic cid seq:1 received id:8:adf4d41e8a288e6e:77890d26cc1a04bc4ad17578ce561d43
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:1 PADDING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:1 largest 0 fr:0 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:app decr:1 pn:1 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504173
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74966 pto:78
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 34
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:4 ACK n:0 delay:0 1-0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:7621 need:1169 shrink:6452
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:4 STREAM id:0x0 off:2625 len:1163
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:4 encoded nl:1 trunc:0x4
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:3333
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:3333
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:4533
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:6458 need:1174 shrink:5284
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60C2240:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:5 STREAM id:0x0 off:3788 len:1168
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:5 encoded nl:1 trunc:0x5
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:4533
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:4533
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:5733
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:5290 need:1174 shrink:4116
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:6 STREAM id:0x0 off:4956 len:1168
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:6 encoded nl:1 trunc:0x6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:5733
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:5733
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:6933
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:4122 need:1174 shrink:2948
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60C2450:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:7 STREAM id:0x0 off:6124 len:1168
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:7 encoded nl:1 trunc:0x7
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:6933
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:6933
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:8133
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:2954 need:1174 shrink:1780
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:8 STREAM id:0x0 off:7292 len:1168
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:8 encoded nl:1 trunc:0x8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:8133
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:8133
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:9333
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic split frame now:1786 need:1174 shrink:612
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 posix_memalign: 00005617F60C2660:512 @16
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:9 STREAM id:0x0 off:8460 len:1168
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:1174 need_ack:1 number:9 encoded nl:1 trunc:0x9
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 1200 of 1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:9333
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:9333
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:10533
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 STREAM id:0x0 off:9628 len:612
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 STREAM id:0x0 off:10240 len:0 fin:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 HANDSHAKE DONE
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 NEW_CONNECTION_ID seq:1 retire:0 len:20
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 NEW_CONNECTION_ID seq:2 retire:0 len:20
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 NEW_CONNECTION_ID seq:3 retire:0 len:20
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 NEW_CONNECTION_ID seq:4 retire:0 len:20
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 NEW_CONNECTION_ID seq:5 retire:0 len:20
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 NEW_CONNECTION_ID seq:6 retire:0 len:20
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:10 NEW_CONNECTION_ID seq:7 retire:0 len:20
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:904 need_ack:1 number:10 encoded nl:1 trunc:0xa
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 930 of 930
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:10533
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:10533
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:11463
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504173
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429251
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:112
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 112:429285
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: send:74966 pto:112
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F3C8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F3C8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic key update
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 100
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: fd:6 n:55
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic input handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx short flags:75
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:2 len:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:55 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:11886 rx:1591 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:2 ACK n:0 delay:13 1-0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion ack recovery win:131054 ss:-1 if:10686
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_drop_ack_ranges pn:0 largest:1 fr:1 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:165 fin:0 unacked:10075
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion ack recovery win:131054 ss:-1 if:9486
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1168 fin:0 unacked:8907
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic updated largest received ack:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic rtt sample latest:35 min:34 avg:34 var:13
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429285
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:95
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 95:429269
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:2 PADDING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:2 largest 1 fr:0 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:app decr:1 pn:2 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504174
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74965 pto:95
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 1
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74965 pto:95
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 95
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: fd:6 n:55
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic input handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx short flags:71
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:3 len:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:55 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:11886 rx:1646 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:3 ACK n:0 delay:2 3-0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion ack recovery win:131054 ss:-1 if:8286
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1168 fin:0 unacked:7739
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion ack recovery win:131054 ss:-1 if:8130
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:124 fin:0 unacked:7615
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic updated largest received ack:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic rtt sample latest:35 min:34 avg:34 var:10
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429269
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:83
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 83:429257
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:3 PADDING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:3 largest 2 fr:1 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:app decr:1 pn:3 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504174
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74965 pto:83
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74965 pto:83
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 83
client  | Stream 0 ended after 10240 bytes
client  | All done, Closing the connection.
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: fd:6 n:55
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic input handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx short flags:78
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:4 len:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:55 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:11886 rx:1701 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:4 ACK n:0 delay:5 5-0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion slow start win:132254 ss:-1 if:6930
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_drop_ack_ranges pn:1 largest:3 fr:2 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1163 fin:0 unacked:6452
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion slow start win:133454 ss:-1 if:5730
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1168 fin:0 unacked:5284
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic updated largest received ack:5
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic rtt sample latest:33 min:33 avg:34 var:8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429257
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:43
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 43:429249
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:4 PADDING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:4 largest 3 fr:1 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:app decr:1 pn:4 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504206
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74933 pto:43
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 32
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74933 pto:43
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 43
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: fd:6 n:55
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic input handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx short flags:7a
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:5 len:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:55 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:11886 rx:1756 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:5 ACK n:0 delay:3 7-0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion slow start win:134654 ss:-1 if:4530
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1168 fin:0 unacked:4116
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion slow start win:135854 ss:-1 if:3330
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1168 fin:0 unacked:2948
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic updated largest received ack:7
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic rtt sample latest:35 min:33 avg:34 var:6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429249
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:33
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 33:429241
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:5 PADDING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:5 largest 4 fr:2 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:app decr:1 pn:5 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504208
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74931 pto:33
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 2
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74931 pto:33
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 33
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: fd:6 n:55
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic input handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx short flags:6b
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:6 len:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:55 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:11886 rx:1811 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:6 ACK n:0 delay:4 9-0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion slow start win:137054 ss:-1 if:2130
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1168 fin:0 unacked:1780
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion slow start win:138254 ss:-1 if:930
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:1168 fin:0 unacked:612
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic updated largest received ack:9
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic rtt sample latest:37 min:33 avg:34 var:5
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429241
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:27
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 27:429237
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:6 PADDING
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:6 largest 5 fr:3 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:app decr:1 pn:6 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504210
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74929 pto:27
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 2
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: read:74929 pto:27
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 27
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll: fd:6 ev:0001 d:00007FBF1DCAA108
server  | 2025/04/30 12:22:37 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic recvmsg: fd:6 n:46
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic input handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx short flags:74
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx dcid len:20 0000000000000002dc99c541c517444c2409c8a6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx clearflags:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet rx number:7 len:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet len:46 via sock seq:0 path seq:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic path seq:0 status tx:11886 rx:1857 valid:1 st:2 mtu:1200
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:7 ACK n:0 delay:9 10-0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion slow start win:139184 ss:-1 if:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:612 fin:0 unacked:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 ack len:0 fin:1 unacked:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic stream id:0x0 close
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 reusable connection: 1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 update posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic updated largest received ack:10
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic rtt sample latest:37 min:33 avg:34 var:4
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429237
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer unset
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame rx app:7 CONNECTION_CLOSE_APP err:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 post event 00005617F606F308
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_ack_packet pn:7 largest 6 fr:4 nranges:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet done rc:0 level:app decr:1 pn:7 perr:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504210
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: draining read:74929
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F248
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic push handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic output app packet max:1200 min:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic frame tx app:11 MAX_STREAMS limit:129 bidi:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic packet tx app bytes:3 need_ack:1 number:11 encoded nl:1 trunc:0xb
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 sendmsg: 29 of 29
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic congestion send if:29
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer: 6, old: 504139, new: 504210
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic lost timer pto:60
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 60:429270
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic state: draining send:74929 pto:60
server  | 2025/04/30 12:22:37 [debug] 21#0: posted event 00005617F606F308
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 delete posted event 00005617F606F308
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic close handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic close initiated rc:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic close immediate term:0 drain:1 error:1 ""
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer add: 6: 180:429390
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429270
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429273
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: 180
server  | 2025/04/30 12:22:37 [debug] 21#0: timer delta: 181
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 429390
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic close handler
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic close resumed rc:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:0 closed nsock:7
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:1 closed nsock:6
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:2 closed nsock:5
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:3 closed nsock:4
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:4 closed nsock:3
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:5 closed nsock:2
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:6 closed nsock:1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic socket seq:7 closed nsock:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic close completed
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 quic ngx_quic_send_alert() level:app alert:0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 SSL_shutdown: 1
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: 6: 504139
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 reusable connection: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 run cleanup: 00005617F6085E40
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 event timer del: -1: 504139
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C7240
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C6230
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C5220
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C09F0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60BB9D0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60BA9C0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6066640
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F606F5E0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F606EC40
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60877F0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6063210, unused: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60B9E00, unused: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6065180, unused: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60703F0, unused: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60701E0, unused: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6085D40, unused: 8
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6085B30, unused: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60647E0, unused: 0
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60649F0, unused: 32
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6064C00, unused: 32
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6064E10, unused: 32
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C1A00, unused: 72
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6064170, unused: 40
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6064380, unused: 40
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F6064590, unused: 72
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C1C10, unused: 72
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C1E20, unused: 72
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C2030, unused: 32
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C2240, unused: 32
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C2450, unused: 32
server  | 2025/04/30 12:22:37 [debug] 21#0: *6 free: 00005617F60C2660, unused: 256
server  | 2025/04/30 12:22:37 [debug] 21#0: worker cycle
server  | 2025/04/30 12:22:37 [debug] 21#0: epoll timer: -1
client  | Received a request to close the connection.
client  | Out of 1 zero RTT packets, 1 were acked by the server.
client  | Address Discovery mode: 0 / 0 (0:0)
client  | Quic Bit was NOT greased by the client.
client  | Quic Bit was NOT greased by the server.
client  | ECN was not received.
client  | ECN was not acknowledged.
client  | Received 10240 bytes in 0.343322 seconds, 0.238610 Mbps.
client  | Sent 17 bytes in 0.343322 seconds, 0.000396 Mbps.
client  | max_data_local: 1048576
client  | max_stream_data_local: 2097152
client  | max_data_remote: 8585216
client  | max_stream_data_remote: 0
client  | ack_delay_remote: 1000 ... 4287
client  | max_ack_gap_remote: 2
client  | ack_delay_local: 25000 ... 25000
client  | max_ack_gap_local: 2
client  | max_mtu_sent: 1252
client  | max_mtu_received: 1200
client  | System call duration max: 3
client  | System call duration smoothed: 0
client  | System call duration deviation: 0
client  | Received ticket from server4 (hq-interop):
client  | ticket time = 1746015757081, kx = 17, suite = 1301, 282 ticket, 32 secret.
client  | lifetime = 299, age_add = a7f9cf15, 1 nonce, 256 ticket, 12 extensions.
client  | ticket extensions: 42(ED: ffffffff),
client  | 4 extra bytes at the end of the extensions
client  | Client exit with code = 0

client exited with code 0
Aborting on container exit...
 Container server  Stopping
 Container client  Stopping
 Container client  Stopped
 Container server  Stopped
 Container sim  Stopping
 Container sim  Stopped

2025-04-30 12:22:47,803 Using the client's key log file.
2025-04-30 12:22:47,811 
2025-04-30 12:22:47,812 Using the client's key log file.
2025-04-30 12:22:47,812 Using the client's key log file.
2025-04-30 12:22:47,819 
2025-04-30 12:22:47,820 Using the client's key log file.
2025-04-30 12:22:47,820 Using the client's key log file.
2025-04-30 12:22:48,642 Check of downloaded files succeeded.