2025-04-30 08:51:36,963 Generated random file: plxwhsjewy of size: 5120 2025-04-30 08:51:36,963 Generated random file: eijeabfoqw of size: 10240 2025-04-30 08:51:36,963 Requests: https://server4:443/plxwhsjewy https://server4:443/eijeabfoqw 2025-04-30 08:51:37,021 2025-04-30 08:51:37,022 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_ilw_yh_q/ TESTCASE_SERVER=resumption TESTCASE_CLIENT=resumption WWW=/tmp/www_o7_olr1p/ DOWNLOADS=/tmp/download_l0nb35j6/ SERVER_LOGS=/tmp/logs_server_z6ejo10d CLIENT_LOGS=/tmp/logs_client_rxoo3e4i SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=ghcr.io/microsoft/msquic/qns:main SERVER=ghcr.io/nginx/nginx-quic-qns:latest REQUESTS="https://server4:443/plxwhsjewy https://server4:443/eijeabfoqw" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 08:51:54,808 Container sim Created Container server Recreate Container client Recreate Container client Recreated Container server Recreated Attaching to client, server, sim sim | waiting 10s for server:443 server | 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] server | Endpoint's IPv4 address is 193.167.100.100 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 client | Setting up routes... client | Actual changes: client | tx-checksumming: off client | tx-checksum-ip-generic: off client | tx-checksum-sctp: off client | tcp-segmentation-offload: off client | tx-tcp-segmentation: off [requested on] client | tx-tcp-ecn-segmentation: off [requested on] client | tx-tcp-mangleid-segmentation: off [requested on] client | tx-tcp6-segmentation: off [requested on] client | tx-udp-segmentation: off [requested on] client | Endpoint's IPv4 address is 193.167.0.100 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: resumption client | Endpoint's IPv6 address is fd00:cafe:cafe::100 server | 2025/04/30 08:51:37 [debug] 21#0: bind() 0.0.0.0:443 #5 server | 2025/04/30 08:51:37 [debug] 21#0: bind() 0.0.0.0:443 #6 server | 2025/04/30 08:51:37 [debug] 21#0: bind() [::]:443 #7 server | 2025/04/30 08:51:37 [debug] 21#0: bind() [::]:443 #8 server | 2025/04/30 08:51:37 [debug] 21#0: add cleanup: 00005603C4D40750 server | 2025/04/30 08:51:37 [notice] 21#0: using the "epoll" event method server | 2025/04/30 08:51:37 [debug] 21#0: counter: 00007F0867044080, 1 server | 2025/04/30 08:51:37 [notice] 21#0: nginx/1.27.0 (9270:d1b8568f3042) server | 2025/04/30 08:51:37 [notice] 21#0: built by gcc 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2) server | 2025/04/30 08:51:37 [notice] 21#0: OS: Linux 6.11.0-1012-azure server | 2025/04/30 08:51:37 [notice] 21#0: getrlimit(RLIMIT_NOFILE): 1048576:1048576 server | 2025/04/30 08:51:37 [debug] 21#0: write: 9, 00007FFE6FE49210, 3, 0 server | 2025/04/30 08:51:37 [debug] 21#0: setproctitle: "nginx: master process /usr/sbin/nginx -c /etc/nginx/nginx.conf" server | 2025/04/30 08:51:37 [notice] 21#0: start worker processes server | 2025/04/30 08:51:37 [debug] 21#0: channel 3:9 server | 2025/04/30 08:51:37 [notice] 21#0: start worker process 22 server | 2025/04/30 08:51:37 [debug] 21#0: sigsuspend server | 2025/04/30 08:51:37 [debug] 22#0: add cleanup: 00005603C4D407D8 server | 2025/04/30 08:51:37 [debug] 22#0: malloc: 00005603C4D437D0:16 server | 2025/04/30 08:51:37 [debug] 22#0: add cleanup: 00005603C4D407F0 server | 2025/04/30 08:51:37 [debug] 22#0: malloc: 00005603C4D41AD0:16 server | 2025/04/30 08:51:37 [debug] 22#0: notify eventfd: 11 server | 2025/04/30 08:51:37 [debug] 22#0: testing the EPOLLRDHUP flag: success server | 2025/04/30 08:51:37 [debug] 22#0: malloc: 00005603C4D29430:6144 server | 2025/04/30 08:51:37 [debug] 22#0: malloc: 00007F08669B6010:253952 server | 2025/04/30 08:51:37 [debug] 22#0: malloc: 00005603C4D45890:98304 server | 2025/04/30 08:51:37 [debug] 22#0: malloc: 00005603C4D5D8A0:98304 server | 2025/04/30 08:51:37 [debug] 22#0: epoll add event: fd:5 op:1 ev:00002001 server | 2025/04/30 08:51:37 [debug] 22#0: epoll add event: fd:6 op:1 ev:00002001 server | 2025/04/30 08:51:37 [debug] 22#0: epoll add event: fd:7 op:1 ev:00002001 server | 2025/04/30 08:51:37 [debug] 22#0: epoll add event: fd:8 op:1 ev:00002001 server | 2025/04/30 08:51:37 [debug] 22#0: epoll add event: fd:9 op:1 ev:00002001 server | 2025/04/30 08:51:37 [debug] 22#0: setproctitle: "nginx: worker process" server | 2025/04/30 08:51:37 [debug] 22#0: worker cycle server | 2025/04/30 08:51:37 [debug] 22#0: epoll timer: -1 client | wait-for-it.sh: waiting 30 seconds for sim:57832 server | 2025/04/30 08:51:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:38 [debug] 22#0: posix_memalign: 00005603C4D41B30:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: malloc: 00005603C4D437F0:1207 server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic recvmsg: 193.167.100.2:48114 fd:6 n:1207 server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic run server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic packet rx dcid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic packet rx scid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic address validation token len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *1 sending version negotiation packet sim | server:443 is available after 1.029154334s server | 2025/04/30 08:51:38 [debug] 22#0: *1 sendmsg: 11 of 11 server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 08:51:38 [debug] 22#0: *1 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 08:51:38 [debug] 22#0: *1 reusable connection: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *1 free: 00005603C4D437F0 server | 2025/04/30 08:51:38 [debug] 22#0: *1 free: 00005603C4D41B30, unused: 24 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 818 server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#0: epoll timer: -1 server | 2025/04/30 08:51:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:38 [debug] 22#0: posix_memalign: 00005603C4D41B30:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: malloc: 00005603C4D437F0:1207 server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic recvmsg: 193.167.100.2:48114 fd:6 n:1207 server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic run server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic packet rx dcid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic packet rx scid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic address validation token len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *2 sending version negotiation packet server | 2025/04/30 08:51:38 [debug] 22#0: *2 sendmsg: 11 of 11 server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 08:51:38 [debug] 22#0: *2 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 08:51:38 [debug] 22#0: *2 reusable connection: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *2 free: 00005603C4D437F0 server | 2025/04/30 08:51:38 [debug] 22#0: *2 free: 00005603C4D41B30, unused: 24 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 0 server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#0: epoll timer: -1 server | 2025/04/30 08:51:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:38 [debug] 22#0: posix_memalign: 00005603C4D41B30:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: malloc: 00005603C4D437F0:1207 server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic recvmsg: 193.167.100.2:48114 fd:6 n:1207 server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic run server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic packet rx dcid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic packet rx scid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic address validation token len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *3 sending version negotiation packet server | 2025/04/30 08:51:38 [debug] 22#0: *3 sendmsg: 11 of 11 server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 08:51:38 [debug] 22#0: *3 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 08:51:38 [debug] 22#0: *3 reusable connection: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *3 free: 00005603C4D437F0 server | 2025/04/30 08:51:38 [debug] 22#0: *3 free: 00005603C4D41B30, unused: 24 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 0 server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#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 | Connecting to server4 client | Client params (before files):-test:R -sslkeylogfile:/logs/keys.log server | 2025/04/30 08:51:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:38 [debug] 22#0: posix_memalign: 00005603C4D41B30:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: malloc: 00005603C4D437F0:1220 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic recvmsg: 193.167.0.100:38896 fd:6 n:1220 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic run server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx long flags:c7 version:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx init len:1202 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx dcid len:8 93c62d58d9493574 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx scid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic address validation token len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 malloc: 00005603C4D2AC40:2448 server | 2025/04/30 08:51:38 [debug] 22#0: *4 malloc: 00005603C4D2B5E0:1528 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D41D40:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_set_initial_secret server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic socket seq:0 listening at sid:00000000000000045da816dd3a8b01ac3b3dbb0e nsock:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic cid seq:0 received id:0::00000000000000000000000000000000 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D2C1E0:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 created addr:193.167.0.100:38896 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 set active tx:0 rx:0 valid:0 st:0 mtu:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D2C3F0:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic socket seq:-1 listening at sid:93c62d58d9493574 nsock:2 server | 2025/04/30 08:51:38 [debug] 22#0: *4 reusable connection: 1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic connection created server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx clearflags:c3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx number:0 len:4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet len:1220 via sock seq:0 path seq:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 status tx:0 rx:1220 valid:0 st:0 mtu:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stateless reset token a33e4b499c3936aa7374e562cd197a12 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx init:0 CRYPTO len:297 off:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL server name: "server4" server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL ALPN supported by client: hq-interop server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL ALPN supported by client: h3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL ALPN supported by client: hq-29 server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL ALPN supported by client: h3-29 server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL ALPN selected: h3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_add_handshake_data server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic SSL_get_peer_quic_transport_params(): params_len:57 server | 2025/04/30 08:51:38 [info] 22#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 08:51:38 [debug] 22#0: *4 quic transport parameters parsed ok server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp disable active migration: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp idle_timeout:10000 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp max_udp_payload_size:1472 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp max_data:16777216 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp max_stream_data_bidi_local:65536 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp max_stream_data_bidi_remote:65536 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp max_stream_data_uni:65536 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp initial_max_streams_bidi:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp initial_max_streams_uni:3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp ack_delay_exponent:8 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp max_ack_delay:26 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp active_connection_id_limit:4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic tp initial source_connection_id len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 malloc: 00005603C4D202E0:4096 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D212F0:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 post event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_set_write_secret() level:2 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_add_handshake_data server | 2025/04/30 08:51:38 [debug] 22#0: *4 malloc: 00005603C4D22450:4096 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_set_write_secret() level:3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_flush_flight() server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_set_read_secret() level:2 server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL_do_handshake: -1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL_get_error: 2 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx init:0 PADDING server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet done rc:0 level:init decr:1 pn:0 perr:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 10000:406864 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 60000:456864 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: read:10000 close:60000 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 236 server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic push handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D75C30:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic output init packet max:1200 min:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx init:0 ACK n:0 delay:0 0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx init:0 CRYPTO len:90 off:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet tx init bytes:99 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic output hs packet max:1054 min:1054 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx hs:0 CRYPTO len:726 off:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet tx hs bytes:1008 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 sendmsg: 1200 of 1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:146 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer: 6, old: 406864, new: 406864 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic lost timer pto:997 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 997:397861 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: send:10000 pto:997 close:60000 server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#0: epoll timer: 997 server | 2025/04/30 08:51:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic recvmsg: fd:6 n:109 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic input handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx long flags:e5 version:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx hs len:80 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000000045da816dd3a8b01ac3b3dbb0e server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx scid len:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx clearflags:e3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx number:1 len:4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet len:109 via sock seq:0 path seq:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 status tx:1200 rx:1329 valid:0 st:0 mtu:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion ack recovery win:131054 ss:-1 if:1054 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic socket seq:-1 closed nsock:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer del: 6: 397861 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic lost timer pto:963 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 963:397861 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 in handshake tx:1200 rx:1329 valid:1 st:0 mtu:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 post event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx hs:1 ACK n:0 delay:2 0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:2 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion ack recovery win:131054 ss:-1 if:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic updated largest received ack:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic rtt sample latest:34 min:34 avg:34 var:17 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer del: 6: 397861 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic lost timer unset server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx hs:1 CRYPTO len:52 off:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_set_read_secret() level:3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_add_handshake_data server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_flush_flight() server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL_do_handshake: 1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 SSL: TLSv1.3, cipher: "TLS_AES_256_GCM_SHA384 Kx=GENERIC Au=GENERIC Enc=AESGCM(256) Mac=AEAD" server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 post event 00005603C4D2B3C8 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic lost timer unset server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 schedule mtu:1472 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 100:396998 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic create sockets has:1 max:4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic socket seq:1 listening at sid:000000000000000444a24729b06a90d4e32387d3 nsock:2 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stateless reset token 234e0707b8ac37cac508f1abb21181a4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic socket seq:2 listening at sid:0000000000000004d0df6c03770a7ec4e17c2e14 nsock:3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D1F250:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stateless reset token 0fddaef1bffab69ec19814271fe64401 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic socket seq:3 listening at sid:0000000000000004dd0a22ce9cffa41496ccf6ad nsock:4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D1F460:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stateless reset token fe7d29cfb40da6f707edf19e5df25e16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic init streams server | 2025/04/30 08:51:38 [debug] 22#0: *4 http3 init server | 2025/04/30 08:51:38 [debug] 22#0: *4 http3 init session server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D1F670:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 add cleanup: 00005603C4D214D0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 75000:471898 server | 2025/04/30 08:51:38 [debug] 22#0: *4 http3 send settings server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic creating server uni stream streams:0 max:3 id:0x3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 create server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D764C0:16384 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 reusable connection: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 add cleanup: 00005603C4D76580 server | 2025/04/30 08:51:38 [debug] 22#0: *4 reusable connection: 1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 http3 create uni stream, type:0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 quic send_chain sent:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 flush limit:65536 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D7A4D0:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 flush len:1 last:0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 post event 00005603C4D45AD0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 quic send_chain sent:8 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 flush limit:65535 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 flush len:8 last:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic creating server uni stream streams:1 max:3 id:0x7 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x7 create server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D7A6E0:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D7A8F0:16384 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 reusable connection: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *6 add cleanup: 00005603C4D7A9B0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 reusable connection: 1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 http3 create uni stream, type:3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 malloc: 00005603C4D7E900:4096 server | 2025/04/30 08:51:38 [debug] 22#0: *6 quic send_chain sent:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x7 flush limit:65536 server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x7 flush len:1 last:0 server | 2025/04/30 08:51:38 [debug] 22#0: *6 post event 00005603C4D45B30 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer del: 6: 456864 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:1 largest -1 fr:0 nranges:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet done rc:0 level:hs decr:1 pn:1 perr:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer: 6, old: 406864, new: 406898 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: read:9966 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 34 server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic push handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic output app packet max:1200 min:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 CRYPTO len:572 off:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 HANDSHAKE DONE server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:1 retire:0 len:20 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:2 retire:0 len:20 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:3 retire:0 len:20 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 STREAM id:0x3 off:0 len:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 STREAM id:0x3 off:1 len:8 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:0 STREAM id:0x7 off:0 len:1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet tx app bytes:719 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 sendmsg: 737 of 737 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:737 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer: 6, old: 406864, new: 406898 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic lost timer pto:128 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 128:397026 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: send:9966 pto:128 server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D2B3C8 server | 2025/04/30 08:51:38 [debug] 22#0: *4 delete posted event 00005603C4D2B3C8 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic key update server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D45AD0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 delete posted event 00005603C4D45AD0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 http3 dummy read handler server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D45B30 server | 2025/04/30 08:51:38 [debug] 22#0: *6 delete posted event 00005603C4D45B30 server | 2025/04/30 08:51:38 [debug] 22#0: *6 http3 dummy read handler server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#0: epoll timer: 100 server | 2025/04/30 08:51:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic recvmsg: fd:6 n:1252 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic input handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx short flags:44 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000000045da816dd3a8b01ac3b3dbb0e server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx clearflags:43 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx number:2 len:4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet len:1252 via sock seq:0 path seq:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 status tx:1937 rx:2581 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx app:2 PING server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx app:2 PADDING server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:2 largest -1 fr:0 nranges:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 post event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:2 perr:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer: 6, old: 406864, new: 406899 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: read:9965 pto:127 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 1 server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic push handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 25:396924 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: read:9965 push:25 pto:127 server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#0: epoll timer: 25 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 25 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer del: 6: 396924 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic push handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 posix_memalign: 00005603C4D7F910:512 @16 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic output app packet max:1200 min:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame tx app:1 ACK n:0 delay:3125 2 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet tx app bytes:6 need_ack:0 number:1 encoded nl:1 trunc:0x1 server | 2025/04/30 08:51:38 [debug] 22#0: *4 sendmsg: 24 of 24 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:737 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:737 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion send if:737 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: read:9940 pto:102 server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#0: epoll timer: 74 server | 2025/04/30 08:51:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic recvmsg: fd:6 n:49 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic input handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx short flags:61 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000000045da816dd3a8b01ac3b3dbb0e server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx clearflags:63 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet rx number:3 len:4 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet len:49 via sock seq:0 path seq:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic path seq:0 status tx:1961 rx:2630 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx app:3 ACK n:0 delay:0 0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic congestion slow start win:131791 ss:-1 if:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 ack len:1 fin:0 unacked:8 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 ack len:8 fin:0 unacked:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x7 ack len:1 fin:0 unacked:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 post event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic updated largest received ack:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic rtt sample latest:32 min:32 avg:34 var:13 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer del: 6: 397026 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic lost timer unset server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic frame rx app:3 CONNECTION_CLOSE_APP err:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 post event 00005603C4D2B308 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:3 largest 2 fr:0 nranges:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:3 perr:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer: 6, old: 406864, new: 406930 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: draining read:9934 server | 2025/04/30 08:51:38 [debug] 22#0: timer delta: 6 server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic push handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic state: draining read:9934 server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D2B308 server | 2025/04/30 08:51:38 [debug] 22#0: *4 delete posted event 00005603C4D2B308 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic close handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic close initiated rc:0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic close immediate term:0 drain:1 error:1 "" server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer add: 6: 336:397266 server | 2025/04/30 08:51:38 [debug] 22#0: *5 post event 00005603C4D5DAE0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 http3 dummy read handler server | 2025/04/30 08:51:38 [debug] 22#0: *5 http3 close stream server | 2025/04/30 08:51:38 [debug] 22#0: *5 delete posted event 00005603C4D5DAE0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 reusable connection: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *5 run cleanup: 00005603C4D76580 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 cleanup server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x3 close server | 2025/04/30 08:51:38 [debug] 22#0: *4 post event 00005603C4D2B308 server | 2025/04/30 08:51:38 [debug] 22#0: *5 free: 00005603C4D764C0, unused: 15960 server | 2025/04/30 08:51:38 [debug] 22#0: *6 post event 00005603C4D5DB40 server | 2025/04/30 08:51:38 [debug] 22#0: *6 http3 dummy read handler server | 2025/04/30 08:51:38 [debug] 22#0: *6 http3 close stream server | 2025/04/30 08:51:38 [debug] 22#0: *6 delete posted event 00005603C4D5DB40 server | 2025/04/30 08:51:38 [debug] 22#0: *6 reusable connection: 0 server | 2025/04/30 08:51:38 [debug] 22#0: *6 run cleanup: 00005603C4D7A9B0 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x7 cleanup server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic stream id:0x7 close server | 2025/04/30 08:51:38 [debug] 22#0: *4 update posted event 00005603C4D2B308 server | 2025/04/30 08:51:38 [debug] 22#0: *6 free: 00005603C4D7A8F0, unused: 15960 server | 2025/04/30 08:51:38 [debug] 22#0: *4 event timer del: 6: 396998 server | 2025/04/30 08:51:38 [debug] 22#0: posted event 00005603C4D2B308 server | 2025/04/30 08:51:38 [debug] 22#0: *4 delete posted event 00005603C4D2B308 server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic close handler server | 2025/04/30 08:51:38 [debug] 22#0: *4 quic close resumed rc:0 server | 2025/04/30 08:51:38 [debug] 22#0: worker cycle server | 2025/04/30 08:51:38 [debug] 22#0: epoll timer: 336 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 337 server | 2025/04/30 08:51:39 [debug] 22#0: *4 event timer del: 6: 397266 server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic close handler server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic close resumed rc:0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic socket seq:0 closed nsock:3 server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic socket seq:1 closed nsock:2 server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic socket seq:2 closed nsock:1 server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic socket seq:3 closed nsock:0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic close completed server | 2025/04/30 08:51:39 [debug] 22#0: *4 quic ngx_quic_send_alert() level:app alert:0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 SSL_shutdown: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *4 event timer del: 6: 406864 server | 2025/04/30 08:51:39 [debug] 22#0: *4 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 run cleanup: 00005603C4D214D0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 event timer del: -1: 471898 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D7E900 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D22450 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D202E0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D2B5E0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D2AC40 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D437F0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D41B30, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D41D40, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D2C1E0, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D2C3F0, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D212F0, unused: 8 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D75C30, unused: 24 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D1F250, unused: 72 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D1F460, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D1F670, unused: 32 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D7A4D0, unused: 112 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D7A6E0, unused: 80 server | 2025/04/30 08:51:39 [debug] 22#0: *4 free: 00005603C4D7F910, unused: 336 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: -1 server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: posix_memalign: 00005603C4D1F250:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: malloc: 00005603C4D437F0:1220 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: 193.167.0.100:51768 fd:6 n:1220 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic run server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx long flags:c5 version:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx init len:1202 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:8 80192687a0558f8a server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx scid len:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic address validation token len:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 malloc: 00005603C4D2AC40:2448 server | 2025/04/30 08:51:39 [debug] 22#0: *7 malloc: 00005603C4D2B5E0:1528 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D75C30:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_set_initial_secret server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:0 listening at sid:0000000000000004eb09b3fd7f3f09858ef22ca4 nsock:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic cid seq:0 received id:0::00000000000000000000000000000000 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D212F0:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 created addr:193.167.0.100:51768 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 set active tx:0 rx:0 valid:0 st:0 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D2C3F0:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:-1 listening at sid:80192687a0558f8a nsock:2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic connection created server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:c3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:0 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:1220 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:0 rx:1220 valid:0 st:0 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stateless reset token a3a06740442e9494b555c4a23245356c server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx init:0 CRYPTO len:620 off:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL server name: "server4" server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL ALPN supported by client: hq-interop server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL ALPN supported by client: h3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL ALPN supported by client: hq-29 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL ALPN supported by client: h3-29 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL ALPN selected: h3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_add_handshake_data server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic SSL_get_peer_quic_transport_params(): params_len:57 server | 2025/04/30 08:51:39 [info] 22#0: *7 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 08:51:39 [debug] 22#0: *7 quic transport parameters parsed ok server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp disable active migration: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp idle_timeout:10000 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp max_udp_payload_size:1472 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp max_data:16777216 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp max_stream_data_bidi_local:65536 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp max_stream_data_bidi_remote:65536 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp max_stream_data_uni:65536 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp initial_max_streams_bidi:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp initial_max_streams_uni:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp ack_delay_exponent:8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp max_ack_delay:26 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp active_connection_id_limit:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic tp initial source_connection_id len:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 malloc: 00005603C4D22450:4096 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D2C1E0:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_set_write_secret() level:2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_add_handshake_data server | 2025/04/30 08:51:39 [debug] 22#0: *7 malloc: 00005603C4D764C0:4096 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_set_write_secret() level:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_add_handshake_data server | 2025/04/30 08:51:39 [debug] 22#0: *7 malloc: 00005603C4D774D0:4096 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D41D40:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_flush_flight() server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_set_read_secret() level:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_set_read_secret() level:2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL_do_handshake: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic init streams server | 2025/04/30 08:51:39 [debug] 22#0: *7 http3 init server | 2025/04/30 08:51:39 [debug] 22#0: *7 http3 init session server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D41B30:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 add cleanup: 00005603C4D41E40 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 75000:472360 server | 2025/04/30 08:51:39 [debug] 22#0: *7 http3 send settings server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic creating server uni stream streams:0 max:3 id:0x3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 create server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D20DF0:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D784E0:16384 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *8 add cleanup: 00005603C4D785A0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 http3 create uni stream, type:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 malloc: 00005603C4D7C4F0:4096 server | 2025/04/30 08:51:39 [debug] 22#0: *8 quic send_chain sent:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 flush limit:65536 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 flush len:1 last:0 server | 2025/04/30 08:51:39 [debug] 22#0: *8 post event 00005603C4D45B30 server | 2025/04/30 08:51:39 [debug] 22#0: *8 quic send_chain sent:8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 flush limit:65535 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D21000:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 flush len:8 last:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic creating server uni stream streams:1 max:3 id:0x7 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x7 create server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D7D500:16384 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *9 add cleanup: 00005603C4D7D5C0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 http3 create uni stream, type:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 malloc: 00005603C4D81510:4096 server | 2025/04/30 08:51:39 [debug] 22#0: *9 quic send_chain sent:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x7 flush limit:65536 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D82520:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x7 flush len:1 last:0 server | 2025/04/30 08:51:39 [debug] 22#0: *9 post event 00005603C4D45AD0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx init:0 PADDING server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:init decr:1 pn:0 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 10000:407360 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:10000 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 93 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic output init packet max:1200 min:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx init:0 ACK n:0 delay:0 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx init:0 CRYPTO len:96 off:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet tx init bytes:105 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic output hs packet max:1048 min:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx hs:0 CRYPTO len:177 off:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet tx hs bytes:181 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic output app packet max:821 min:821 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:0 CRYPTO len:572 off:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:0 STREAM id:0x3 off:0 len:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:0 STREAM id:0x3 off:1 len:8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:0 STREAM id:0x7 off:0 len:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet tx app bytes:803 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 sendmsg: 1200 of 1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:152 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:379 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407360 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:997 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 997:398357 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: send:10000 pto:997 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D45B30 server | 2025/04/30 08:51:39 [debug] 22#0: *8 delete posted event 00005603C4D45B30 server | 2025/04/30 08:51:39 [debug] 22#0: *8 http3 dummy read handler server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D45AD0 server | 2025/04/30 08:51:39 [debug] 22#0: *9 delete posted event 00005603C4D45AD0 server | 2025/04/30 08:51:39 [debug] 22#0: *9 http3 dummy read handler server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 997 client | Sending request: GET /plxwhsjewy server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: fd:6 n:109 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic input handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx long flags:e6 version:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx hs len:80 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:20 0000000000000004eb09b3fd7f3f09858ef22ca4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx scid len:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:e3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:1 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:109 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:1200 rx:1329 valid:0 st:0 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion ack recovery win:131054 ss:-1 if:1048 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:-1 closed nsock:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 398357 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:963 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 963:398357 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 in handshake tx:1200 rx:1329 valid:1 st:0 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx hs:1 ACK n:0 delay:0 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_handle_ack_frame level:2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion ack recovery win:131054 ss:-1 if:821 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic updated largest received ack:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic rtt sample latest:34 min:34 avg:34 var:17 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 398357 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:68 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 68:397462 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx hs:1 CRYPTO len:52 off:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_set_read_secret() level:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL_do_handshake: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL: TLSv1.3, cipher: "TLS_AES_256_GCM_SHA384 Kx=GENERIC Au=GENERIC Enc=AESGCM(256) Mac=AEAD" server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL reused session server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B3C8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397462 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:94 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 94:397488 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 schedule mtu:1472 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 100:397494 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic create sockets has:1 max:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:1 listening at sid:00000000000000048a74535cdda84a2b04f0aae6 nsock:2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stateless reset token 2f8acaeab3ee574346d89bbedc800909 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D202E0:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:2 listening at sid:00000000000000046537e70a834b9d52f190c2ad nsock:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stateless reset token a10cabc8dd8d88e75733205b5bd5e732 server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D204F0:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:3 listening at sid:0000000000000004225d339c59cf8da41526eac2 nsock:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stateless reset token 6554cadfeec4bfd6e3d0003e1b0acf1d server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:1 largest -1 fr:0 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:hs decr:1 pn:1 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407394 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9966 pto:94 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 34 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic output app packet max:1200 min:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:1 HANDSHAKE DONE server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:1 NEW_CONNECTION_ID seq:1 retire:0 len:20 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:1 NEW_CONNECTION_ID seq:2 retire:0 len:20 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:1 NEW_CONNECTION_ID seq:3 retire:0 len:20 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet tx app bytes:121 need_ack:1 number:1 encoded nl:1 trunc:0x1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 sendmsg: 139 of 139 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:821 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:821 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:960 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407394 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397488 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:128 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 128:397522 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: send:9966 pto:128 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B3C8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B3C8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic key update server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 100 server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: fd:6 n:1252 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic input handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx short flags:62 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:20 0000000000000004eb09b3fd7f3f09858ef22ca4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:63 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:2 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:1252 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:1339 rx:2581 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:2 PING server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:2 PADDING server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:2 largest -1 fr:0 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:app decr:1 pn:2 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407395 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9965 pto:127 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 1 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 25:397420 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9965 push:25 pto:127 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 25 server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: fd:6 n:50 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic input handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx short flags:7f server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:20 0000000000000004eb09b3fd7f3f09858ef22ca4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:63 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:3 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:50 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:1339 rx:2631 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:3 ACK n:0 delay:0 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion ack recovery win:131054 ss:-1 if:139 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 ack len:1 fin:0 unacked:8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 ack len:8 fin:0 unacked:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x7 ack len:1 fin:0 unacked:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic updated largest received ack:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic rtt sample latest:35 min:34 avg:34 var:13 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397522 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:111 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 111:397506 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:3 STREAM id:0x0 len:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 is missing server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 create server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D20700:512 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 posix_memalign: 00005603C4D82730:16384 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 add cleanup: 00005603C4D827F0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 post event 00005603C4D45B90 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:3 largest 2 fr:0 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:app decr:1 pn:3 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407395 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9965 push:25 pto:111 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 0 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D45B90 server | 2025/04/30 08:51:39 [debug] 22#0: *10 delete posted event 00005603C4D45B90 server | 2025/04/30 08:51:39 [debug] 22#0: *10 quic init stream server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 init request stream server | 2025/04/30 08:51:39 [debug] 22#0: *10 add cleanup: 00005603C4D82860 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 472360 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 wait request handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 recv buf:1024 server | 2025/04/30 08:51:39 [debug] 22#0: *10 quic stream id:0x0 recv() not ready server | 2025/04/30 08:51:39 [debug] 22#0: *10 event timer add: 6: 60000:457395 server | 2025/04/30 08:51:39 [debug] 22#0: *10 reusable connection: 1 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic output app packet max:1200 min:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:2 ACK n:0 delay:0 3-2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet tx app bytes:5 need_ack:0 number:2 encoded nl:1 trunc:0x2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 sendmsg: 23 of 23 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:139 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:139 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:139 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9965 push:25 pto:111 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 25 server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: fd:6 n:62 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic input handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx short flags:65 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:20 0000000000000004eb09b3fd7f3f09858ef22ca4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:63 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:4 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:62 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:1362 rx:2693 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:4 STREAM id:0x0 len:17 fin:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 flow control msd:17/65536 md:17/8585216 server | 2025/04/30 08:51:39 [debug] 22#0: *10 post event 00005603C4D45B90 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:4 largest 3 fr:1 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:app decr:1 pn:4 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407395 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9965 push:25 pto:111 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 0 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D45B90 server | 2025/04/30 08:51:39 [debug] 22#0: *10 delete posted event 00005603C4D45B90 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 wait request handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 recv buf:1024 server | 2025/04/30 08:51:39 [debug] 22#0: *10 quic stream id:0x0 recv len:17 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 flow update 17 server | 2025/04/30 08:51:39 [debug] 22#0: *10 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 posix_memalign: 00005603C4D86740:4096 @16 server | 2025/04/30 08:51:39 [debug] 22#0: *10 add cleanup: 00005603C4D875A0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 process request server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 parse headers server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 parse varlen int 1861 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 parse varlen int 5152 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http3 parse headers type:1861, len:5152 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 recv buf:1024 server | 2025/04/30 08:51:39 [info] 22#0: *10 client prematurely closed connection while reading client request, client: 193.167.0.100, server: localhost server | 2025/04/30 08:51:39 [debug] 22#0: *10 http finalize request: 400, "?" a:1, c:1 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http terminate request count:1 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http terminate cleanup count:1 blk:0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http request count:1 blk:0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 http close request server | 2025/04/30 08:51:39 [debug] 22#0: *10 http log handler server | 193.167.0.100 - - [30/Apr/2025:08:51:39 +0000] "-" 400 0 "-" "-" server | 2025/04/30 08:51:39 [debug] 22#0: *10 run cleanup: 00005603C4D875A0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 free: 00005603C4D86740, unused: 291 server | 2025/04/30 08:51:39 [debug] 22#0: *10 close http connection: 6 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 reset server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *10 event timer del: 6: 457395 server | 2025/04/30 08:51:39 [debug] 22#0: *10 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *10 run cleanup: 00005603C4D82860 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 75000:472395 server | 2025/04/30 08:51:39 [debug] 22#0: *10 run cleanup: 00005603C4D827F0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 cleanup server | 2025/04/30 08:51:39 [debug] 22#0: *10 free: 00005603C4D82730, unused: 14952 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic output app packet max:1200 min:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:3 ACK n:0 delay:0 4-2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:3 RESET_STREAM id:0x0 error_code:0x102 final_size:0x0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet tx app bytes:10 need_ack:1 number:3 encoded nl:1 trunc:0x3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 sendmsg: 28 of 28 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:139 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:139 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:167 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407395 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397506 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:112 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 112:397507 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: send:9965 push:25 pto:112 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 25 client | (null): Peer aborted send! (397411 ms) server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 26 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397420 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: send:9939 pto:86 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 73 server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: fd:6 n:1332 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic input handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx short flags:70 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:20 0000000000000004eb09b3fd7f3f09858ef22ca4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:63 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:5 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:1332 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:1390 rx:4025 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:5 PING server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:5 PADDING server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:5 largest 4 fr:2 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:app decr:1 pn:5 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407427 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9933 pto:80 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 6 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 25:397452 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9933 push:25 pto:80 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 25 server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: fd:6 n:46 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic input handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx short flags:78 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:20 0000000000000004eb09b3fd7f3f09858ef22ca4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:63 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:6 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:46 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:1390 rx:4071 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:6 ACK n:0 delay:0 3-1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion slow start win:131193 ss:-1 if:28 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion slow start win:131221 ss:-1 if:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_drop_ack_ranges pn:4 largest:5 fr:3 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 ack reset final_size:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x0 close server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic updated largest received ack:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic rtt sample latest:32 min:32 avg:34 var:10 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397507 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer unset server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:6 largest 5 fr:0 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:app decr:1 pn:6 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407427 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: read:9933 push:25 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 0 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B248 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic push handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic output app packet max:1200 min:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:4 ACK n:0 delay:0 6-5 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame tx app:4 MAX_STREAMS limit:129 bidi:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet tx app bytes:8 need_ack:1 number:4 encoded nl:1 trunc:0x4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 sendmsg: 26 of 26 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic congestion send if:26 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407427 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic lost timer pto:100 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 100:397527 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: send:9933 push:25 pto:100 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 25 server | 2025/04/30 08:51:39 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F08669B6108 server | 2025/04/30 08:51:39 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic recvmsg: fd:6 n:44 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic input handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx short flags:68 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx dcid len:20 0000000000000004eb09b3fd7f3f09858ef22ca4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx clearflags:63 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet rx number:7 len:4 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet len:44 via sock seq:0 path seq:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic path seq:0 status tx:1416 rx:4115 valid:1 st:2 mtu:1200 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic frame rx app:7 CONNECTION_CLOSE_APP err:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B308 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_ack_packet pn:7 largest 6 fr:1 nranges:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic packet done rc:0 level:app decr:1 pn:7 perr:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer: 6, old: 407360, new: 407427 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic state: draining read:9933 push:25 pto:100 server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 0 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B308 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B308 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close initiated rc:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close immediate term:0 drain:1 error:1 "" server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer add: 6: 300:397727 server | 2025/04/30 08:51:39 [debug] 22#0: *8 post event 00005603C4D5DB40 server | 2025/04/30 08:51:39 [debug] 22#0: *8 http3 dummy read handler server | 2025/04/30 08:51:39 [debug] 22#0: *8 http3 close stream server | 2025/04/30 08:51:39 [debug] 22#0: *8 delete posted event 00005603C4D5DB40 server | 2025/04/30 08:51:39 [debug] 22#0: *8 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *8 run cleanup: 00005603C4D785A0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 cleanup server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x3 close server | 2025/04/30 08:51:39 [debug] 22#0: *7 post event 00005603C4D2B308 server | 2025/04/30 08:51:39 [debug] 22#0: *8 free: 00005603C4D784E0, unused: 15960 server | 2025/04/30 08:51:39 [debug] 22#0: *9 post event 00005603C4D5DAE0 server | 2025/04/30 08:51:39 [debug] 22#0: *9 http3 dummy read handler server | 2025/04/30 08:51:39 [debug] 22#0: *9 http3 close stream server | 2025/04/30 08:51:39 [debug] 22#0: *9 delete posted event 00005603C4D5DAE0 server | 2025/04/30 08:51:39 [debug] 22#0: *9 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *9 run cleanup: 00005603C4D7D5C0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x7 cleanup server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic stream id:0x7 close server | 2025/04/30 08:51:39 [debug] 22#0: *7 update posted event 00005603C4D2B308 server | 2025/04/30 08:51:39 [debug] 22#0: *9 free: 00005603C4D7D500, unused: 15960 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397452 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397527 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397494 server | 2025/04/30 08:51:39 [debug] 22#0: posted event 00005603C4D2B308 server | 2025/04/30 08:51:39 [debug] 22#0: *7 delete posted event 00005603C4D2B308 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close resumed rc:0 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: 300 client | client | TARGET VHDCRZSQUMBGA2E VERSION ALPN client | ============================================ client | server4 --------------- client | client | Total execution time: 0.873s client | server | 2025/04/30 08:51:39 [debug] 22#0: timer delta: 301 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 397727 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close handler server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close resumed rc:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:0 closed nsock:3 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:1 closed nsock:2 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:2 closed nsock:1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic socket seq:3 closed nsock:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic close completed server | 2025/04/30 08:51:39 [debug] 22#0: *7 quic ngx_quic_send_alert() level:app alert:0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 SSL_shutdown: 1 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: 6: 407360 server | 2025/04/30 08:51:39 [debug] 22#0: *7 reusable connection: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 run cleanup: 00005603C4D41E40 server | 2025/04/30 08:51:39 [debug] 22#0: *7 event timer del: -1: 472395 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D81510 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D7C4F0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D774D0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D764C0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D22450 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D2B5E0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D2AC40 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D437F0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D1F250, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D75C30, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D212F0, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D2C3F0, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D2C1E0, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D41D40, unused: 8 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D41B30, unused: 16 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D20DF0, unused: 0 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D21000, unused: 80 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D82520, unused: 48 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D202E0, unused: 216 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D204F0, unused: 216 server | 2025/04/30 08:51:39 [debug] 22#0: *7 free: 00005603C4D20700, unused: 224 server | 2025/04/30 08:51:39 [debug] 22#0: worker cycle server | 2025/04/30 08:51:39 [debug] 22#0: epoll timer: -1 client | Client complete. client | Script complete. 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 08:51:54,901 Using the client's key log file. 2025-04-30 08:51:54,909 2025-04-30 08:51:54,910 Using the client's key log file. 2025-04-30 08:51:54,910 Using the client's key log file. 2025-04-30 08:51:54,917 2025-04-30 08:51:54,918 Using the client's key log file. 2025-04-30 08:51:54,918 Using the client's key log file. 2025-04-30 08:51:55,768 Missing files: ['plxwhsjewy', 'eijeabfoqw']