2025-04-30 09:12:14,009 Generated random file: ntpcxbtdmz of size: 1024
2025-04-30 09:12:14,009 Requests: https://server4:443/ntpcxbtdmz
2025-04-30 09:12:14,069 
2025-04-30 09:12:14,069 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_1_y2pudn/ TESTCASE_SERVER=handshake TESTCASE_CLIENT=handshake WWW=/tmp/www_b5hnz8tr/ DOWNLOADS=/tmp/download_f5tityf0/ SERVER_LOGS=/tmp/logs_server_75oxre3y CLIENT_LOGS=/tmp/logs_client_6f967m_b SCENARIO="simple-p2p --delay=750ms --bandwidth=10Mbps --queue=25" CLIENT=cloudflare/quiche-qns:latest SERVER=ghcr.io/nginx/nginx-quic-qns:latest REQUESTS="https://server4:443/ntpcxbtdmz"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 09:12:37,935  Container sim  Recreate
 Container sim  Recreated
 Container client  Recreate
 Container server  Recreate
 Container server  Recreated
 Container client  Recreated
Attaching to client, server, sim
sim     | waiting 10s for server:443
client  | Setting up routes...
server  | Setting up routes...
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  | 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]
server  | Endpoint's IPv4 address is 193.167.100.100
client  | Endpoint's IPv4 address is 193.167.0.100
client  | Endpoint's IPv6 address is fd00:cafe:cafe::100
server  | Endpoint's IPv6 address is fd00:cafe:cafe:100::100
client  | supported
server  | >>> Starting nginx server...
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: handshake
server  | 2025/04/30 09:12:14 [debug] 21#0: bind() 0.0.0.0:443 #5 
server  | 2025/04/30 09:12:14 [debug] 21#0: bind() 0.0.0.0:443 #6 
server  | 2025/04/30 09:12:14 [debug] 21#0: bind() [::]:443 #7 
server  | 2025/04/30 09:12:14 [debug] 21#0: bind() [::]:443 #8 
server  | 2025/04/30 09:12:14 [debug] 21#0: add cleanup: 0000556B90C59750
server  | 2025/04/30 09:12:14 [notice] 21#0: using the "epoll" event method
server  | 2025/04/30 09:12:14 [debug] 21#0: counter: 00007F8A5C2B5080, 1
server  | 2025/04/30 09:12:14 [notice] 21#0: nginx/1.27.0 (9270:d1b8568f3042)
server  | 2025/04/30 09:12:14 [notice] 21#0: built by gcc 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2) 
server  | 2025/04/30 09:12:14 [notice] 21#0: OS: Linux 6.11.0-1012-azure
server  | 2025/04/30 09:12:14 [notice] 21#0: getrlimit(RLIMIT_NOFILE): 1048576:1048576
server  | 2025/04/30 09:12:14 [debug] 21#0: write: 9, 00007FFDA80AF630, 3, 0
server  | 2025/04/30 09:12:14 [debug] 21#0: setproctitle: "nginx: master process /usr/sbin/nginx -c /etc/nginx/nginx.conf"
server  | 2025/04/30 09:12:14 [notice] 21#0: start worker processes
server  | 2025/04/30 09:12:14 [debug] 21#0: channel 3:9
server  | 2025/04/30 09:12:14 [notice] 21#0: start worker process 22
server  | 2025/04/30 09:12:14 [debug] 21#0: sigsuspend
server  | 2025/04/30 09:12:14 [debug] 22#0: add cleanup: 0000556B90C597D8
server  | 2025/04/30 09:12:14 [debug] 22#0: malloc: 0000556B90C5C7D0:16
server  | 2025/04/30 09:12:14 [debug] 22#0: add cleanup: 0000556B90C597F0
server  | 2025/04/30 09:12:14 [debug] 22#0: malloc: 0000556B90C5AAD0:16
server  | 2025/04/30 09:12:14 [debug] 22#0: notify eventfd: 11
server  | 2025/04/30 09:12:14 [debug] 22#0: testing the EPOLLRDHUP flag: success
server  | 2025/04/30 09:12:14 [debug] 22#0: malloc: 0000556B90C42430:6144
server  | 2025/04/30 09:12:14 [debug] 22#0: malloc: 00007F8A5BC27010:253952
server  | 2025/04/30 09:12:14 [debug] 22#0: malloc: 0000556B90C5E890:98304
server  | 2025/04/30 09:12:14 [debug] 22#0: malloc: 0000556B90C768A0:98304
server  | 2025/04/30 09:12:14 [debug] 22#0: epoll add event: fd:5 op:1 ev:00002001
server  | 2025/04/30 09:12:14 [debug] 22#0: epoll add event: fd:6 op:1 ev:00002001
server  | 2025/04/30 09:12:14 [debug] 22#0: epoll add event: fd:7 op:1 ev:00002001
server  | 2025/04/30 09:12:14 [debug] 22#0: epoll add event: fd:8 op:1 ev:00002001
server  | 2025/04/30 09:12:14 [debug] 22#0: epoll add event: fd:9 op:1 ev:00002001
server  | 2025/04/30 09:12:14 [debug] 22#0: setproctitle: "nginx: worker process"
server  | 2025/04/30 09:12:14 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:14 [debug] 22#0: epoll timer: -1
client  | wait-for-it: waiting 30 seconds for sim:57832
server  | 2025/04/30 09:12:15 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:15 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: posix_memalign: 0000556B90C5AB30:512 @16
server  | 2025/04/30 09:12:15 [debug] 22#0: malloc: 0000556B90C5C7F0:1207
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic recvmsg: 193.167.100.2:48177 fd:6 n:1207
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic run
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic packet rx dcid len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic packet rx scid len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic address validation token len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 sending version negotiation packet
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 sendmsg: 11 of 11
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 reusable connection: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 free: 0000556B90C5C7F0
server  | 2025/04/30 09:12:15 [debug] 22#0: *1 free: 0000556B90C5AB30, unused: 24
server  | 2025/04/30 09:12:15 [debug] 22#0: timer delta: 830
server  | 2025/04/30 09:12:15 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:15 [debug] 22#0: epoll timer: -1
server  | 2025/04/30 09:12:15 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:15 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: posix_memalign: 0000556B90C5AB30:512 @16
server  | 2025/04/30 09:12:15 [debug] 22#0: malloc: 0000556B90C5C7F0:1207
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic recvmsg: 193.167.100.2:48177 fd:6 n:1207
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic run
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic packet rx dcid len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic packet rx scid len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic address validation token len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 sending version negotiation packet
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 sendmsg: 11 of 11
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 reusable connection: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 free: 0000556B90C5C7F0
server  | 2025/04/30 09:12:15 [debug] 22#0: *2 free: 0000556B90C5AB30, unused: 24
server  | 2025/04/30 09:12:15 [debug] 22#0: timer delta: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:15 [debug] 22#0: epoll timer: -1
server  | 2025/04/30 09:12:15 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
sim     | server:443 is available after 1.041194095s
server  | 2025/04/30 09:12:15 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: posix_memalign: 0000556B90C5AB30:512 @16
server  | 2025/04/30 09:12:15 [debug] 22#0: malloc: 0000556B90C5C7F0:1207
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic recvmsg: 193.167.100.2:48177 fd:6 n:1207
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic run
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic packet rx dcid len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic packet rx scid len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic address validation token len:0 
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 sending version negotiation packet
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 sendmsg: 11 of 11
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 reusable connection: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 free: 0000556B90C5C7F0
server  | 2025/04/30 09:12:15 [debug] 22#0: *3 free: 0000556B90C5AB30, unused: 24
server  | 2025/04/30 09:12:15 [debug] 22#0: timer delta: 0
server  | 2025/04/30 09:12:15 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:15 [debug] 22#0: epoll timer: -1
sim     | Using scenario: simple-p2p --delay=750ms --bandwidth=10Mbps --queue=25
sim     | tcpdump: listening on eth1, link-type EN10MB (Ethernet), snapshot length 262144 bytes
sim     | tcpdump: listening on eth0, link-type EN10MB (Ethernet), snapshot length 262144 bytes
client  | wait-for-it: sim:57832 is available after 1 seconds
client  | ## Starting quiche client...
client  | ## Client params: 
client  | ## Requests: https://server4:443/ntpcxbtdmz
client  | ## Test case: handshake
server  | 2025/04/30 09:12:16 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:16 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:16 [debug] 22#0: posix_memalign: 0000556B90C5AB30:512 @16
server  | 2025/04/30 09:12:16 [debug] 22#0: malloc: 0000556B90C5C7F0:1200
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic recvmsg: 193.167.0.100:56940 fd:6 n:1200
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic run
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet rx long flags:cb version:1
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet rx init len:287
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet rx dcid len:16 af9171afb5d8a3022bceab5a120dc9e9
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet rx scid len:20 88f450aa7e7129b9fe968363226660ec8c6a2c91
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic address validation token len:0 
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 malloc: 0000556B90C43C40:2448
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 malloc: 0000556B90C445E0:1528
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 posix_memalign: 0000556B90C5AD40:512 @16
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_set_initial_secret
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic socket seq:0 listening at sid:0000000000002001109270d9c3982c3864744762 nsock:1
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic cid seq:0 received id:20:88f450aa7e7129b9fe968363226660ec8c6a2c91:00000000000000000000000000000000
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 posix_memalign: 0000556B90C451E0:512 @16
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic path seq:0 created addr:193.167.0.100:56940
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic path seq:0 set active tx:0 rx:0 valid:0 st:0 mtu:1200
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 posix_memalign: 0000556B90C453F0:512 @16
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic socket seq:-1 listening at sid:af9171afb5d8a3022bceab5a120dc9e9 nsock:2
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 reusable connection: 1
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic connection created
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet rx clearflags:c0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet rx number:0 len:1
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet len:1200 via sock seq:0 path seq:0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic path seq:0 status tx:0 rx:1200 valid:0 st:0 mtu:1200
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic stateless reset token c64602d1508a8b281944a61844a4ecf2
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic frame rx init:0 CRYPTO len:266 off:0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 SSL server name: "server4"
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 SSL ALPN supported by client: h3
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 SSL ALPN supported by client: hq-interop
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 SSL ALPN supported by client: http/0.9
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 SSL ALPN selected: h3
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_add_handshake_data
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic SSL_get_peer_quic_transport_params(): params_len:75
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic transport parameters parsed ok
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp disable active migration: 1
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp idle_timeout:30000
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp max_udp_payload_size:1350
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp max_data:10000000
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp max_stream_data_bidi_local:1000000
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp max_stream_data_bidi_remote:1000000
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp max_stream_data_uni:1000000
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp initial_max_streams_bidi:100
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp initial_max_streams_uni:100
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp ack_delay_exponent:3
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp max_ack_delay:25
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp active_connection_id_limit:8
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic tp initial source_connection_id len:20 88f450aa7e7129b9fe968363226660ec8c6a2c91
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 posix_memalign: 0000556B90C38F90:512 @16
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 malloc: 0000556B90C391A0:4096
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_set_write_secret() level:2
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_add_handshake_data
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 malloc: 0000556B90C3B4F0:4096
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 posix_memalign: 0000556B90C3C500:512 @16
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_set_write_secret() level:3
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_flush_flight()
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_set_read_secret() level:2
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 SSL_do_handshake: -1
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 SSL_get_error: 2
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet done rc:0 level:init decr:1 pn:0 perr:0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet rx short flags:0
server  | 2025/04/30 09:12:16 [info] 22#0: *4 quic fixed bit is not set while parsing quic packet, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet done rc:-5 parse failed
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 event timer add: 6: 30000:323133
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 event timer add: 6: 60000:353133
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic state: read:30000 close:60000
server  | 2025/04/30 09:12:16 [debug] 22#0: timer delta: 944
server  | 2025/04/30 09:12:16 [debug] 22#0: posted event 0000556B90C44248
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic output init packet max:1200 min:0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic frame tx init:0 ACK n:0 delay:0 0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic frame tx init:0 CRYPTO len:90 off:0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet tx init bytes:99 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic output hs packet max:1034 min:1034
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic frame tx hs:0 CRYPTO len:717 off:0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic packet tx hs bytes:968 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic congestion send if:166
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic congestion send if:1200
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic congestion send if:1200
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 event timer: 6, old: 323133, new: 323133
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic lost timer pto:997
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 event timer add: 6: 997:294130
server  | 2025/04/30 09:12:16 [debug] 22#0: *4 quic state: send:30000 pto:997 close:60000
server  | 2025/04/30 09:12:16 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:16 [debug] 22#0: epoll timer: 997
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:17 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic recvmsg: fd:6 n:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic input handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx long flags:cc version:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx init len:287
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx dcid len:16 af9171afb5d8a3022bceab5a120dc9e9
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx scid len:20 88f450aa7e7129b9fe968363226660ec8c6a2c91
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic address validation token len:0 
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx clearflags:c0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx number:1 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet len:1200 via sock seq:-1 path seq:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic path seq:0 status tx:1200 rx:2400 valid:0 st:0 mtu:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx init:1 CRYPTO len:266 off:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic resend packet pnum:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion lost recovery win:131054 ss:-1 if:1034
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic resend packet pnum:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion lost recovery win:131054 ss:-1 if:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:1 largest 0 fr:0 nranges:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:0 level:init decr:1 pn:1 perr:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx short flags:0
server  | 2025/04/30 09:12:17 [info] 22#0: *4 quic fixed bit is not set while parsing quic packet, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:-5 parse failed
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 323133
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 30000:324129
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: read:30000 pto:1 close:59004
server  | 2025/04/30 09:12:17 [debug] 22#0: timer delta: 996
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic output init packet max:1200 min:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx init:1 ACK n:0 delay:0 1-0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx init:1 CRYPTO len:90 off:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet tx init bytes:99 need_ack:1 number:1 encoded nl:1 trunc:0x1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic output hs packet max:1034 min:1034
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx hs:1 CRYPTO len:717 off:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet tx hs bytes:968 need_ack:1 number:1 encoded nl:1 trunc:0x1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:166
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer: 6, old: 324129, new: 324129
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 294130
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic lost timer pto:997
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 997:295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: send:30000 pto:997 close:59004
server  | 2025/04/30 09:12:17 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll timer: 997
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:17 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic recvmsg: fd:6 n:1350
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic input handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx long flags:c2 version:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx init len:23
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx scid len:20 88f450aa7e7129b9fe968363226660ec8c6a2c91
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic address validation token len:0 
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx clearflags:c0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx number:2 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet len:1350 via sock seq:0 path seq:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic path seq:0 status tx:2400 rx:3750 valid:0 st:0 mtu:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx init:2 ACK n:0 delay:86 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic updated largest received ack:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic lost timer pto:487
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 487:295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:2 largest 1 fr:1 nranges:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:0 level:init decr:1 pn:2 perr:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx long flags:e1 version:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx hs len:62
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx scid len:20 88f450aa7e7129b9fe968363226660ec8c6a2c91
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx clearflags:e0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx number:3 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion slow start win:131220 ss:-1 if:1034
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:-1 closed nsock:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic lost timer pto:487
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 487:295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic path seq:0 in handshake tx:2400 rx:3750 valid:1 st:0 mtu:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx hs:3 ACK n:0 delay:62 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:2
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic updated largest received ack:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic lost timer pto:487
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 487:295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx hs:3 CRYPTO len:36 off:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_set_read_secret() level:3
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_add_handshake_data
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_flush_flight()
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 SSL_do_handshake: 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 SSL: TLSv1.3, cipher: "TLS_AES_128_GCM_SHA256 Kx=GENERIC Au=GENERIC Enc=AESGCM(128) Mac=AEAD"
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 post event 0000556B90C443C8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion slow start win:132254 ss:-1 if:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 295126
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic lost timer unset
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic path seq:0 schedule mtu:1350
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 100:294739
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic create sockets has:1 max:8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:1 listening at sid:00000000000020014130a10ba9c4ff7aa3210a91 nsock:2
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stateless reset token 57836507bf0dc9cce585afd2ae35ea69
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C8F190:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:2 listening at sid:0000000000002001323ee02ef210d27085a0a9b4 nsock:3
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stateless reset token 3e6df9634583fede8fb525f0b411f8ba
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C38250:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:3 listening at sid:000000000000200139726f608d051a57de45146e nsock:4
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stateless reset token 93360ef693c61cfee96a45cbecf2d22e
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C38460:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:4 listening at sid:0000000000002001ce3d8883f736813cf1d2c7bd nsock:5
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stateless reset token 89528447cca5923957a2686a52896bdb
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C38670:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:5 listening at sid:0000000000002001af6bb3b3742fd799e7fa6776 nsock:6
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stateless reset token 2c8e33dfce73979881202ca3fa8427f9
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C8F810:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:6 listening at sid:00000000000020011be25eb69e03c9cb0f61aba2 nsock:7
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stateless reset token 5ea2df6b0a92aeb6099c1707ca859cf8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C8FA20:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic socket seq:7 listening at sid:00000000000020011a16872622f7ca74e7bb4779 nsock:8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stateless reset token e60406529f82b9bd8394a2066445ce60
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic init streams
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 http3 init
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 http3 init session
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C8FC30:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 add cleanup: 0000556B90C8F348
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 75000:369639
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 http3 send settings
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic creating server uni stream streams:0 max:100 id:0x3
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x3 create
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C8FE40:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C90050:16384 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *5 add cleanup: 0000556B90C90110
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 http3 create uni stream, type:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *5 quic send_chain sent:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x3 flush limit:1000000
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x3 flush len:1 last:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *5 post event 0000556B90C5EAD0
server  | 2025/04/30 09:12:17 [debug] 22#0: *5 quic send_chain sent:8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x3 flush limit:999999
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x3 flush len:8 last:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic creating server uni stream streams:1 max:100 id:0x7
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x7 create
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C94060:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C94270:16384 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *6 add cleanup: 0000556B90C94330
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 http3 create uni stream, type:3
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 malloc: 0000556B90C98280:4096
server  | 2025/04/30 09:12:17 [debug] 22#0: *6 quic send_chain sent:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x7 flush limit:1000000
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x7 flush len:1 last:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *6 post event 0000556B90C5EB30
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 353133
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:3 largest -1 fr:0 nranges:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:0 level:hs decr:1 pn:3 perr:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx short flags:49
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx number:4 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx app:4 NEW_CONNECTION_ID seq:1 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C99290:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic cid seq:1 received id:20:5dea0f5728e0fd100adde585ad6bb5eb43449e1d:1342325a708216ab38c3b4ba2f688fa5
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx app:4 STREAM id:0x2 off:0 len:19
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x2 is missing
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x2 create
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C994A0:16384 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 add cleanup: 0000556B90C99560
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 post event 0000556B90C5EB90
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x2 flow control msd:19/65536 md:19/8585216
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 malloc: 0000556B90C9D4B0:4096
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C9E4C0:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx app:4 PADDING
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:4 largest -1 fr:0 nranges:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:4 perr:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 324129
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 30000:324639
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: read:30000
server  | 2025/04/30 09:12:17 [debug] 22#0: timer delta: 510
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C443C8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 delete posted event 0000556B90C443C8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic key update
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C5EAD0
server  | 2025/04/30 09:12:17 [debug] 22#0: *5 delete posted event 0000556B90C5EAD0
server  | 2025/04/30 09:12:17 [debug] 22#0: *5 http3 dummy read handler
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C5EB30
server  | 2025/04/30 09:12:17 [debug] 22#0: *6 delete posted event 0000556B90C5EB30
server  | 2025/04/30 09:12:17 [debug] 22#0: *6 http3 dummy read handler
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C5EB90
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 delete posted event 0000556B90C5EB90
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 quic init stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 init uni stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 read handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x2 recv buf:128
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 quic stream id:0x2 recv len:19
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x2 flow update 19
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse uni
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse varlen int 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 control stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse control
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse varlen int 4
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse frame type:4
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse varlen int 16
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse frame len:16
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse settings
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse varlen int 3778676410733637486
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse varlen int 298339339407796312
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 param #3778676410733637486:298339339407796312
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 http3 parse settings done
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x2 recv buf:128
server  | 2025/04/30 09:12:17 [debug] 22#0: *7 quic stream id:0x2 recv() not ready
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 ACK n:0 delay:0 4
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 CRYPTO len:540 off:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 HANDSHAKE DONE
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:1 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:2 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:3 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:4 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:5 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:6 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:7 retire:0 len:20
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 STREAM id:0x3 off:0 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 STREAM id:0x3 off:1 len:8
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:0 STREAM id:0x7 off:0 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet tx app bytes:852 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 sendmsg: 890 of 890
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:890
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer: 6, old: 324639, new: 324639
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic lost timer pto:1022
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 1022:295661
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: send:30000 pto:1022
server  | 2025/04/30 09:12:17 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll timer: 100
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:17 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic recvmsg: fd:6 n:44
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic input handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx short flags:47
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx number:5 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet len:44 via sock seq:0 path seq:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic path seq:0 status tx:3290 rx:3794 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx app:5 STREAM id:0x6 off:0 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x6 is missing
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x6 create
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90C9E6D0:16384 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 add cleanup: 0000556B90C9E790
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 post event 0000556B90C5EBF0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x6 flow control msd:1/65536 md:20/8585216
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90CA26E0:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 malloc: 0000556B90CA28F0:4096
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:5 largest 4 fr:0 nranges:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:5 perr:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer: 6, old: 324639, new: 324641
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: read:29998 pto:1020
server  | 2025/04/30 09:12:17 [debug] 22#0: timer delta: 2
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C5EBF0
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 delete posted event 0000556B90C5EBF0
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 quic init stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 http3 init uni stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 http3 read handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x6 recv buf:128
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 quic stream id:0x6 recv len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x6 flow update 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 http3 parse uni
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 http3 parse varlen int 2
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 http3 encoder stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 http3 parse encoder instruction
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x6 recv buf:128
server  | 2025/04/30 09:12:17 [debug] 22#0: *8 quic stream id:0x6 recv() not ready
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 25:294666
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: read:29998 push:25 pto:1020
server  | 2025/04/30 09:12:17 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll timer: 25
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:17 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic recvmsg: fd:6 n:44
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic input handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx short flags:58
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx number:6 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet len:44 via sock seq:0 path seq:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic path seq:0 status tx:3290 rx:3838 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx app:6 STREAM id:0xa off:0 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0xa is missing
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0xa create
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90CA3900:16384 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 add cleanup: 0000556B90CA39C0
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 post event 0000556B90C5EC50
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0xa flow control msd:1/65536 md:21/8585216
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90CA7910:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 malloc: 0000556B90CA7B20:4096
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:6 largest 5 fr:1 nranges:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:6 perr:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer: 6, old: 324639, new: 324641
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: read:29998 push:25 pto:1020
server  | 2025/04/30 09:12:17 [debug] 22#0: timer delta: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C5EC50
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 delete posted event 0000556B90C5EC50
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 quic init stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 http3 init uni stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 http3 read handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0xa recv buf:128
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 quic stream id:0xa recv len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0xa flow update 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 http3 parse uni
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 http3 parse varlen int 3
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 http3 decoder stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 http3 parse decoder instruction
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0xa recv buf:128
server  | 2025/04/30 09:12:17 [debug] 22#0: *9 quic stream id:0xa recv() not ready
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:1 ACK n:0 delay:0 6-4
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet tx app bytes:5 need_ack:0 number:1 encoded nl:1 trunc:0x1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 sendmsg: 43 of 43
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:890
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:890
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:890
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: read:29998 push:25 pto:1020
server  | 2025/04/30 09:12:17 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll timer: 25
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:17 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic recvmsg: fd:6 n:111
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic input handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx short flags:5f
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet rx number:7 len:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet len:111 via sock seq:0 path seq:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic path seq:0 status tx:3333 rx:3949 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame rx app:7 STREAM id:0x0 off:0 len:68 fin:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 is missing
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 create
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90CA8B30:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90CA8D40:16384 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 add cleanup: 0000556B90CA8E00
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 post event 0000556B90C5ECB0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 flow control msd:68/65536 md:89/8585216
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 malloc: 0000556B90CACD50:4096
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:7 largest 6 fr:2 nranges:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:7 perr:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer: 6, old: 324639, new: 324641
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: read:29998 push:25 pto:1020
server  | 2025/04/30 09:12:17 [debug] 22#0: timer delta: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C5ECB0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 delete posted event 0000556B90C5ECB0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 quic init stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 init request stream
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 add cleanup: 0000556B90CA8E70
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 369639
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 wait request handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 recv buf:1024
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 quic stream id:0x0 recv len:68
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 flow update 68
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 posix_memalign: 0000556B90CADD60:4096 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 add cleanup: 0000556B90CAEBC0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 process request
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse headers
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse varlen int 4241918911342066605
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse varlen int 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse headers type:4241918911342066605, len:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse varlen int 3171175994855627471
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse varlen int 18
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse headers type:3171175994855627471, len:18
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse varlen int 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse varlen int 30
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse headers type:1, len:30
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field section prefix
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field section prefix done insert_count:0, sign:0, delta_base:0, base:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 check insert count req:0, have:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field ri
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 17
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field ri done static[17]
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 static[17] lookup ":method":"GET"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation done
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 method "GET" 2
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field ri
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 23
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field ri done static[23]
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 static[23] lookup ":scheme":"https"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation done
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 schema "https"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field lri
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 5
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse literal huff:1, len:5
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse literal done "server4"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field lri done static[0] "server4"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 static[0] lookup ":authority":""
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation done
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 authority "server4"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field lri
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 1
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 9
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse literal huff:1, len:9
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse literal done "/ntpcxbtdmz"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field lri done static[1] "/ntpcxbtdmz"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 static[1] lookup ":path":"/"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation done
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 path "/ntpcxbtdmz"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field lri
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 95
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse prefix int 5
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse literal huff:1, len:5
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse literal done "quiche"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field lri done static[95] "quiche"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 static[95] lookup "user-agent":""
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse field representation done
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 parse headers done
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 request line: "GET /ntpcxbtdmz HTTP/3.0"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http uri: "/ntpcxbtdmz"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http args: ""
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http exten: ""
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 posix_memalign: 0000556B90CAED70:4096 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 header: "user-agent: quiche"
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 recv buf:1024
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 rewrite phase: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 test location: "/"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 using configuration "/"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http cl:-1 max:1048576
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 rewrite phase: 2
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 post rewrite phase: 3
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 generic phase: 4
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 generic phase: 5
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 access phase: 6
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 access phase: 7
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 post access phase: 8
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 generic phase: 9
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 generic phase: 10
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 content phase: 11
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 content phase: 12
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 content phase: 13
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http filename: "/www/ntpcxbtdmz"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 add cleanup: 0000556B90CAEC00
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http static fd: 3
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 header len:192
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: ":status: 200"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "server: nginx/1.27.0"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "date: Wed, 30 Apr 2025 09:12:17 GMT"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "content-type: application/octet-stream"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "content-length: 1024"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "last-modified: Wed, 30 Apr 2025 09:12:14 GMT"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "ETag: "6811e96e-400""
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "Alt-Svc: hq-29=":443""
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http3 output header: "Accept-Ranges: bytes"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 write new buf t:1 f:0 0000556B90CAED30, pos 0000556B90CAED30, size: 3 file: 0, size: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 write new buf t:1 f:0 0000556B90CAF2D8, pos 0000556B90CAF2D8, size: 138 file: 0, size: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 write new buf t:1 f:0 0000556B90CAED48, pos 0000556B90CAED48, size: 3 file: 0, size: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http write filter: l:0 f:0 s:144
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http output filter "/ntpcxbtdmz?"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http copy filter: "/ntpcxbtdmz?"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 read: 3, 0000556B90CAF548, 1024, 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http postpone filter "/ntpcxbtdmz?" 0000556B90CAF4E8
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 write old buf t:1 f:0 0000556B90CAED30, pos 0000556B90CAED30, size: 3 file: 0, size: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 write old buf t:1 f:0 0000556B90CAF2D8, pos 0000556B90CAF2D8, size: 138 file: 0, size: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 write old buf t:1 f:0 0000556B90CAED48, pos 0000556B90CAED48, size: 3 file: 0, size: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 write new buf t:1 f:0 0000556B90CAF548, pos 0000556B90CAF548, size: 1024 file: 0, size: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http write filter: l:1 f:0 s:1168
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http write filter limit 2097152
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 malloc: 0000556B90CAFD80:4096
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 quic send_chain sent:1168
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 flush limit:1000000
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 flush len:1168 last:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http write filter 0000000000000000
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http copy filter: 0 "/ntpcxbtdmz?"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http finalize request: 0, "/ntpcxbtdmz?" a:1, c:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http request count:1 blk:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http close request
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 http log handler
server  | 193.167.0.100 - - [30/Apr/2025:09:12:17 +0000] "GET /ntpcxbtdmz HTTP/3.0" 200 1024 "-" "quiche"
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 run cleanup: 0000556B90CAEC00
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 file cleanup: fd:3
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 run cleanup: 0000556B90CAEBC0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 free: 0000556B90CADD60, unused: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 free: 0000556B90CAED70, unused: 919
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 close http connection: 6
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 reusable connection: 0
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 run cleanup: 0000556B90CA8E70
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 75000:369641
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 run cleanup: 0000556B90CA8E00
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 cleanup
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 send shutdown
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 flush limit:998832
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90CADD60:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 update posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic stream id:0x0 flush len:0 last:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *10 free: 0000556B90CA8D40, unused: 14919
server  | 2025/04/30 09:12:17 [debug] 22#0: posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:2 ACK n:0 delay:0 7-4
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic split frame now:1173 need:1157 shrink:16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 posix_memalign: 0000556B90CADF70:512 @16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:2 STREAM id:0x0 off:0 len:1152
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet tx app bytes:1162 need_ack:1 number:2 encoded nl:1 trunc:0x2
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 sendmsg: 1200 of 1200
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:890
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:890
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:2090
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic output app packet max:1200 min:0
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:3 STREAM id:0x0 off:1152 len:16
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic frame tx app:3 STREAM id:0x0 off:1168 len:0 fin:1
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic packet tx app bytes:26 need_ack:1 number:3 encoded nl:1 trunc:0x3
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 sendmsg: 64 of 64
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:2090
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:2090
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic congestion send if:2154
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer: 6, old: 324639, new: 324641
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer del: 6: 295661
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic lost timer pto:1022
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 event timer add: 6: 1022:295663
server  | 2025/04/30 09:12:17 [debug] 22#0: *4 quic state: send:29998 push:25 pto:1022
server  | 2025/04/30 09:12:17 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:17 [debug] 22#0: epoll timer: 25
server  | 2025/04/30 09:12:18 [debug] 22#0: timer delta: 26
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 event timer del: 6: 294666
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic state: send:29972 pto:996
server  | 2025/04/30 09:12:18 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:18 [debug] 22#0: epoll timer: 72
server  | 2025/04/30 09:12:18 [debug] 22#0: timer delta: 72
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 event timer del: 6: 294739
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic path seq:0 send probe mtu:1350 pnum:4 tries:0
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic sendto app packet max:1350 min:1350
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic frame tx app:4 PING
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic packet tx app bytes:1312 need_ack:0 number:4 encoded nl:1 trunc:0x4
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 sendmsg: 1350 of 1350
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic congestion send if:3504
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 event timer del: 6: 295663
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 quic lost timer pto:1022
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 event timer add: 6: 1022:295761
server  | 2025/04/30 09:12:18 [debug] 22#0: *4 event timer add: 6: 1022:295761
server  | 2025/04/30 09:12:18 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:18 [debug] 22#0: epoll timer: 1022
server  | 2025/04/30 09:12:19 [debug] 22#0: timer delta: 1024
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 295761
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic pto timer
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic pto app pto_count:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic sendto app packet max:1200 min:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic frame tx app:5 PING
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet tx app bytes:3 need_ack:0 number:5 encoded nl:1 trunc:0x5
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 sendmsg: 41 of 41
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic congestion send if:3545
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic lost timer pto:1022
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 1022:296785
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 posix_memalign: 0000556B90CAE180:512 @16
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic sendto app packet max:1200 min:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic frame tx app:6 PING
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet tx app bytes:3 need_ack:0 number:6 encoded nl:1 trunc:0x6
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 sendmsg: 41 of 41
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic congestion send if:3586
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 296785
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic lost timer pto:1022
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 1022:296785
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 296785
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic lost timer pto:2044
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 2044:297807
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic state: send:28876 pto:2044
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 295761
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic path seq:0 send probe mtu:1350 pnum:7 tries:1
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic sendto app packet max:1350 min:1350
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic frame tx app:7 PING
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet tx app bytes:1312 need_ack:0 number:7 encoded nl:1 trunc:0x7
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 sendmsg: 1350 of 1350
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic congestion send if:4936
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 297807
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic lost timer pto:2044
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 2044:297807
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 2044:297807
server  | 2025/04/30 09:12:19 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:19 [debug] 22#0: epoll timer: 2044
server  | 2025/04/30 09:12:19 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:19 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic recvmsg: fd:6 n:43
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic input handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx short flags:42
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx number:8 len:1
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet len:43 via sock seq:0 path seq:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic path seq:0 status tx:7379 rx:3992 valid:1 st:3 mtu:1200
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic frame rx app:8 ACK n:0 delay:11 1-0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic congestion slow start win:133144 ss:-1 if:4046
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic ngx_quic_drop_ack_ranges pn:4 largest:7 fr:3 nranges:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x3 ack len:1 fin:0 unacked:8
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x3 ack len:8 fin:0 unacked:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x7 ack len:1 fin:0 unacked:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 post event 0000556B90C44248
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic updated largest received ack:1
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 297807
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic lost timer pto:643
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 643:296785
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:8 largest 7 fr:2 nranges:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:8 perr:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 324639
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 30000:326142
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic state: read:30000 pto:643
server  | 2025/04/30 09:12:19 [debug] 22#0: timer delta: 379
server  | 2025/04/30 09:12:19 [debug] 22#0: posted event 0000556B90C44248
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 delete posted event 0000556B90C44248
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic push handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic state: read:30000 pto:643
server  | 2025/04/30 09:12:19 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:19 [debug] 22#0: epoll timer: 643
server  | 2025/04/30 09:12:19 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F8A5BC27108
server  | 2025/04/30 09:12:19 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic recvmsg: fd:6 n:49
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic input handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx short flags:56
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx dcid len:20 0000000000002001109270d9c3982c3864744762
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx clearflags:40
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet rx number:9 len:1
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet len:49 via sock seq:0 path seq:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic path seq:0 status tx:7379 rx:4041 valid:1 st:3 mtu:1200
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic frame rx app:9 CONNECTION_CLOSE_APP err:256 kthxbye
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 post event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:9 largest 8 fr:3 nranges:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:9 perr:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer: 6, old: 326142, new: 326144
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic state: draining read:29998 pto:641
server  | 2025/04/30 09:12:19 [debug] 22#0: timer delta: 2
server  | 2025/04/30 09:12:19 [debug] 22#0: posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 delete posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic close handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic close initiated rc:0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic close immediate term:0 drain:1 error:1 ""
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer add: 6: 3066:299210
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x0 close
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 post event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *7 post event 0000556B90C5EB90
server  | 2025/04/30 09:12:19 [debug] 22#0: *7 http3 read handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *7 http3 close stream
server  | 2025/04/30 09:12:19 [debug] 22#0: *7 delete posted event 0000556B90C5EB90
server  | 2025/04/30 09:12:19 [debug] 22#0: *7 reusable connection: 0
server  | 2025/04/30 09:12:19 [debug] 22#0: *7 run cleanup: 0000556B90C99560
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x2 cleanup
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x2 close
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 update posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *7 free: 0000556B90C994A0, unused: 15872
server  | 2025/04/30 09:12:19 [debug] 22#0: *5 post event 0000556B90C76AE0
server  | 2025/04/30 09:12:19 [debug] 22#0: *5 http3 dummy read handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *5 http3 close stream
server  | 2025/04/30 09:12:19 [debug] 22#0: *5 delete posted event 0000556B90C76AE0
server  | 2025/04/30 09:12:19 [debug] 22#0: *5 reusable connection: 0
server  | 2025/04/30 09:12:19 [debug] 22#0: *5 run cleanup: 0000556B90C90110
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x3 cleanup
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x3 close
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 update posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *5 free: 0000556B90C90050, unused: 15960
server  | 2025/04/30 09:12:19 [debug] 22#0: *8 post event 0000556B90C5EBF0
server  | 2025/04/30 09:12:19 [debug] 22#0: *8 http3 read handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *8 http3 close stream
server  | 2025/04/30 09:12:19 [debug] 22#0: *8 delete posted event 0000556B90C5EBF0
server  | 2025/04/30 09:12:19 [debug] 22#0: *8 reusable connection: 0
server  | 2025/04/30 09:12:19 [debug] 22#0: *8 run cleanup: 0000556B90C9E790
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x6 cleanup
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x6 close
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 update posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *8 free: 0000556B90C9E6D0, unused: 15872
server  | 2025/04/30 09:12:19 [debug] 22#0: *6 post event 0000556B90C76B40
server  | 2025/04/30 09:12:19 [debug] 22#0: *6 http3 dummy read handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *6 http3 close stream
server  | 2025/04/30 09:12:19 [debug] 22#0: *6 delete posted event 0000556B90C76B40
server  | 2025/04/30 09:12:19 [debug] 22#0: *6 reusable connection: 0
server  | 2025/04/30 09:12:19 [debug] 22#0: *6 run cleanup: 0000556B90C94330
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x7 cleanup
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0x7 close
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 update posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *6 free: 0000556B90C94270, unused: 15960
server  | 2025/04/30 09:12:19 [debug] 22#0: *9 post event 0000556B90C5EC50
server  | 2025/04/30 09:12:19 [debug] 22#0: *9 http3 read handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *9 http3 close stream
server  | 2025/04/30 09:12:19 [debug] 22#0: *9 delete posted event 0000556B90C5EC50
server  | 2025/04/30 09:12:19 [debug] 22#0: *9 reusable connection: 0
server  | 2025/04/30 09:12:19 [debug] 22#0: *9 run cleanup: 0000556B90CA39C0
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0xa cleanup
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic stream id:0xa close
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 update posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *9 free: 0000556B90CA3900, unused: 15872
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 296785
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 event timer del: 6: 297807
server  | 2025/04/30 09:12:19 [debug] 22#0: posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 delete posted event 0000556B90C44308
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic close handler
server  | 2025/04/30 09:12:19 [debug] 22#0: *4 quic close resumed rc:0
server  | 2025/04/30 09:12:19 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:19 [debug] 22#0: epoll timer: 3066
server  | 2025/04/30 09:12:22 [debug] 22#0: timer delta: 3069
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 event timer del: 6: 299210
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic close handler
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic close resumed rc:0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:0 closed nsock:7
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:1 closed nsock:6
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:2 closed nsock:5
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:3 closed nsock:4
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:4 closed nsock:3
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:5 closed nsock:2
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:6 closed nsock:1
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic socket seq:7 closed nsock:0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic close completed
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 quic ngx_quic_send_alert() level:app alert:0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 SSL_shutdown: 1
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 event timer del: 6: 326142
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 reusable connection: 0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 run cleanup: 0000556B90C8F348
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 event timer del: -1: 369641
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CAFD80
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CACD50
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CA7B20
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CA28F0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C9D4B0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C98280
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C3B4F0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C391A0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C445E0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C43C40
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C5C7F0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C5AB30, unused: 1
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C5AD40, unused: 0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C451E0, unused: 72
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C453F0, unused: 10
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C38F90, unused: 96
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C3C500, unused: 48
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C8F190, unused: 48
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C38250, unused: 56
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C38460, unused: 24
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C38670, unused: 24
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C8F810, unused: 72
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C8FA20, unused: 40
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C8FC30, unused: 0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C8FE40, unused: 0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C94060, unused: 0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C99290, unused: 0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90C9E4C0, unused: 0
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CA26E0, unused: 48
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CA7910, unused: 16
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CA8B30, unused: 64
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CADD60, unused: 112
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CADF70, unused: 48
server  | 2025/04/30 09:12:22 [debug] 22#0: *4 free: 0000556B90CAE180, unused: 192
server  | 2025/04/30 09:12:22 [debug] 22#0: worker cycle
server  | 2025/04/30 09:12:22 [debug] 22#0: epoll timer: -1

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

2025-04-30 09:12:38,027 Using the client's key log file.
2025-04-30 09:12:38,036 
2025-04-30 09:12:38,036 Using the client's key log file.
2025-04-30 09:12:38,036 Using the client's key log file.
2025-04-30 09:12:38,044 
2025-04-30 09:12:38,044 Using the client's key log file.
2025-04-30 09:12:38,320 Check of downloaded files succeeded.
2025-04-30 09:12:39,434 Check of downloaded files succeeded.