2025-04-30 11:27:58,763 Generated random file: pmsewxdjvw of size: 1024 2025-04-30 11:27:58,763 Requests: https://server4:443/pmsewxdjvw 2025-04-30 11:27:58,820 2025-04-30 11:27:58,820 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_70by7r8_/ TESTCASE_SERVER=handshake TESTCASE_CLIENT=handshake WWW=/tmp/www_lj494h0e/ DOWNLOADS=/tmp/download_9iujrm4k/ SERVER_LOGS=/tmp/logs_server_70b32a0m CLIENT_LOGS=/tmp/logs_client_yzm54fb1 SCENARIO="simple-p2p --delay=750ms --bandwidth=10Mbps --queue=25" CLIENT=peterdoornbosch/kwik_n_flupke-interop SERVER=ghcr.io/nginx/nginx-quic-qns:latest REQUESTS="https://server4:443/pmsewxdjvw" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 11:28:15,835 Container sim Recreate Container sim Recreated Container client Recreate Container server 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 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 client | Setting up routes... server | 2025/04/30 11:27:59 [debug] 21#0: bind() 0.0.0.0:443 #5 server | 2025/04/30 11:27:59 [debug] 21#0: bind() 0.0.0.0:443 #6 server | 2025/04/30 11:27:59 [debug] 21#0: bind() [::]:443 #7 server | 2025/04/30 11:27:59 [debug] 21#0: bind() [::]:443 #8 server | 2025/04/30 11:27:59 [debug] 21#0: add cleanup: 0000556108C97750 server | 2025/04/30 11:27:59 [notice] 21#0: using the "epoll" event method server | 2025/04/30 11:27:59 [debug] 21#0: counter: 00007F696E7EE080, 1 server | 2025/04/30 11:27:59 [notice] 21#0: nginx/1.27.0 (9270:d1b8568f3042) server | 2025/04/30 11:27:59 [notice] 21#0: built by gcc 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2) server | 2025/04/30 11:27:59 [notice] 21#0: OS: Linux 6.11.0-1012-azure server | 2025/04/30 11:27:59 [notice] 21#0: getrlimit(RLIMIT_NOFILE): 1048576:1048576 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 | 2025/04/30 11:27:59 [debug] 21#0: write: 9, 00007FFDD6AD8290, 3, 0 server | 2025/04/30 11:27:59 [debug] 21#0: setproctitle: "nginx: master process /usr/sbin/nginx -c /etc/nginx/nginx.conf" server | 2025/04/30 11:27:59 [notice] 21#0: start worker processes server | 2025/04/30 11:27:59 [debug] 21#0: channel 3:9 server | 2025/04/30 11:27:59 [notice] 21#0: start worker process 22 server | 2025/04/30 11:27:59 [debug] 21#0: sigsuspend server | 2025/04/30 11:27:59 [debug] 22#0: add cleanup: 0000556108C977D8 server | 2025/04/30 11:27:59 [debug] 22#0: malloc: 0000556108C9A7D0:16 server | 2025/04/30 11:27:59 [debug] 22#0: add cleanup: 0000556108C977F0 server | 2025/04/30 11:27:59 [debug] 22#0: malloc: 0000556108C98AD0:16 server | 2025/04/30 11:27:59 [debug] 22#0: notify eventfd: 11 server | 2025/04/30 11:27:59 [debug] 22#0: testing the EPOLLRDHUP flag: success server | 2025/04/30 11:27:59 [debug] 22#0: malloc: 0000556108C80430:6144 server | 2025/04/30 11:27:59 [debug] 22#0: malloc: 00007F696E160010:253952 server | 2025/04/30 11:27:59 [debug] 22#0: malloc: 0000556108C9C890:98304 server | 2025/04/30 11:27:59 [debug] 22#0: malloc: 0000556108CB48A0:98304 server | 2025/04/30 11:27:59 [debug] 22#0: epoll add event: fd:5 op:1 ev:00002001 server | 2025/04/30 11:27:59 [debug] 22#0: epoll add event: fd:6 op:1 ev:00002001 server | 2025/04/30 11:27:59 [debug] 22#0: epoll add event: fd:7 op:1 ev:00002001 server | 2025/04/30 11:27:59 [debug] 22#0: epoll add event: fd:8 op:1 ev:00002001 server | 2025/04/30 11:27:59 [debug] 22#0: epoll add event: fd:9 op:1 ev:00002001 server | 2025/04/30 11:27:59 [debug] 22#0: setproctitle: "nginx: worker process" server | 2025/04/30 11:27:59 [debug] 22#0: worker cycle server | 2025/04/30 11:27:59 [debug] 22#0: epoll timer: -1 client | Endpoint's IPv4 address is 193.167.0.100 client | Endpoint's IPv6 address is fd00:cafe:cafe::100 client | Certificate was added to keystore client | wait-for-it.sh: waiting 30 seconds for sim:57832 server | 2025/04/30 11:28:00 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:00 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:00 [debug] 22#0: posix_memalign: 0000556108C98B30:512 @16 server | 2025/04/30 11:28:00 [debug] 22#0: malloc: 0000556108C9A7F0:1207 server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic recvmsg: 193.167.100.2:57078 fd:6 n:1207 server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic run server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic packet rx dcid len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic packet rx scid len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic address validation token len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *1 sending version negotiation packet sim | server:443 is available after 1.008237991s server | 2025/04/30 11:28:00 [debug] 22#0: *1 sendmsg: 11 of 11 server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 11:28:00 [debug] 22#0: *1 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 11:28:00 [debug] 22#0: *1 reusable connection: 0 server | 2025/04/30 11:28:00 [debug] 22#0: *1 free: 0000556108C9A7F0 server | 2025/04/30 11:28:00 [debug] 22#0: *1 free: 0000556108C98B30, unused: 24 server | 2025/04/30 11:28:00 [debug] 22#0: timer delta: 818 server | 2025/04/30 11:28:00 [debug] 22#0: worker cycle server | 2025/04/30 11:28:00 [debug] 22#0: epoll timer: -1 server | 2025/04/30 11:28:00 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:00 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:00 [debug] 22#0: posix_memalign: 0000556108C98B30:512 @16 server | 2025/04/30 11:28:00 [debug] 22#0: malloc: 0000556108C9A7F0:1207 server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic recvmsg: 193.167.100.2:57078 fd:6 n:1207 server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic run server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic packet rx dcid len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic packet rx scid len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic address validation token len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *2 sending version negotiation packet server | 2025/04/30 11:28:00 [debug] 22#0: *2 sendmsg: 11 of 11 server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 11:28:00 [debug] 22#0: *2 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 11:28:00 [debug] 22#0: *2 reusable connection: 0 server | 2025/04/30 11:28:00 [debug] 22#0: *2 free: 0000556108C9A7F0 server | 2025/04/30 11:28:00 [debug] 22#0: *2 free: 0000556108C98B30, unused: 24 server | 2025/04/30 11:28:00 [debug] 22#0: timer delta: 0 server | 2025/04/30 11:28:00 [debug] 22#0: worker cycle server | 2025/04/30 11:28:00 [debug] 22#0: epoll timer: -1 server | 2025/04/30 11:28:00 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:00 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:00 [debug] 22#0: posix_memalign: 0000556108C98B30:512 @16 server | 2025/04/30 11:28:00 [debug] 22#0: malloc: 0000556108C9A7F0:1207 server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic recvmsg: 193.167.100.2:57078 fd:6 n:1207 server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic run server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic packet rx dcid len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic packet rx scid len:0 server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic address validation token len:0 sim | Using scenario: simple-p2p --delay=750ms --bandwidth=10Mbps --queue=25 server | 2025/04/30 11:28:00 [debug] 22#0: *3 sending version negotiation packet server | 2025/04/30 11:28:00 [debug] 22#0: *3 sendmsg: 11 of 11 server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 11:28:00 [debug] 22#0: *3 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 11:28:00 [debug] 22#0: *3 reusable connection: 0 server | 2025/04/30 11:28:00 [debug] 22#0: *3 free: 0000556108C9A7F0 server | 2025/04/30 11:28:00 [debug] 22#0: *3 free: 0000556108C98B30, unused: 24 server | 2025/04/30 11:28:00 [debug] 22#0: timer delta: 0 server | 2025/04/30 11:28:00 [debug] 22#0: worker cycle server | 2025/04/30 11:28:00 [debug] 22#0: epoll timer: -1 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 | running kwik Kwik version: 0.10.2 with openjdk 21.0.5 2024-10-15 with https://server4:443/pmsewxdjvw client | 28:01.094 Creating connection with server4:443 with v1 client | 28:01.177 Original destination connection id: ba6223983084c835 (scid: aa9658aaabc704a8) server | 2025/04/30 11:28:02 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:02 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:02 [debug] 22#0: posix_memalign: 0000556108C98B30:512 @16 server | 2025/04/30 11:28:02 [debug] 22#0: malloc: 0000556108C9A7F0:1200 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic recvmsg: 193.167.0.100:41394 fd:6 n:1200 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic run server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet rx long flags:c6 version:1 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet rx init len:1174 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet rx dcid len:8 ba6223983084c835 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet rx scid len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic address validation token len:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 malloc: 0000556108C81C40:2448 server | 2025/04/30 11:28:02 [debug] 22#0: *4 malloc: 0000556108C825E0:1528 server | 2025/04/30 11:28:02 [debug] 22#0: *4 posix_memalign: 0000556108C98D40:512 @16 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_set_initial_secret server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic socket seq:0 listening at sid:00000000000020011c1b61fd1a832c54abd3ea4e nsock:1 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic cid seq:0 received id:8:aa9658aaabc704a8:00000000000000000000000000000000 server | 2025/04/30 11:28:02 [debug] 22#0: *4 posix_memalign: 0000556108C831E0:512 @16 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic path seq:0 created addr:193.167.0.100:41394 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic path seq:0 set active tx:0 rx:0 valid:0 st:0 mtu:1200 server | 2025/04/30 11:28:02 [debug] 22#0: *4 posix_memalign: 0000556108C833F0:512 @16 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic socket seq:-1 listening at sid:ba6223983084c835 nsock:2 server | 2025/04/30 11:28:02 [debug] 22#0: *4 reusable connection: 1 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic connection created server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet rx clearflags:c0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet rx number:0 len:1 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet len:1200 via sock seq:0 path seq:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic path seq:0 status tx:0 rx:1200 valid:0 st:0 mtu:1200 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic stateless reset token 8b36fd76d47dd088e823d4cd9d933eb0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic frame rx init:0 CRYPTO len:257 off:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 SSL server name: "server4" server | 2025/04/30 11:28:02 [debug] 22#0: *4 SSL ALPN supported by client: hq-interop server | 2025/04/30 11:28:02 [debug] 22#0: *4 SSL ALPN selected: hq-interop server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_add_handshake_data server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic SSL_get_peer_quic_transport_params(): params_len:59 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic transport parameters parsed ok server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp disable active migration: 0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp idle_timeout:60000 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp max_udp_payload_size:1500 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp max_data:2500000 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp max_stream_data_bidi_local:250000 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp max_stream_data_bidi_remote:250000 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp max_stream_data_uni:250000 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp initial_max_streams_bidi:3 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp initial_max_streams_uni:3 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp ack_delay_exponent:3 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp max_ack_delay:25 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp active_connection_id_limit:2 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic tp initial source_connection_id len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:02 [debug] 22#0: *4 malloc: 0000556108C77120:4096 server | 2025/04/30 11:28:02 [debug] 22#0: *4 posix_memalign: 0000556108C78130:512 @16 server | 2025/04/30 11:28:02 [debug] 22#0: *4 post event 0000556108C82248 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_set_write_secret() level:2 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_add_handshake_data server | 2025/04/30 11:28:02 [debug] 22#0: *4 malloc: 0000556108C795F0:4096 server | 2025/04/30 11:28:02 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_set_write_secret() level:3 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_flush_flight() server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_set_read_secret() level:2 server | 2025/04/30 11:28:02 [debug] 22#0: *4 SSL_do_handshake: -1 server | 2025/04/30 11:28:02 [debug] 22#0: *4 SSL_get_error: 2 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic frame rx init:0 PADDING server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet done rc:0 level:init decr:1 pn:0 perr:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 event timer add: 6: 60000:315676 server | 2025/04/30 11:28:02 [debug] 22#0: *4 event timer add: 6: 60000:315676 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic state: read:60000 close:60000 server | 2025/04/30 11:28:02 [debug] 22#0: timer delta: 1874 server | 2025/04/30 11:28:02 [debug] 22#0: posted event 0000556108C82248 server | 2025/04/30 11:28:02 [debug] 22#0: *4 delete posted event 0000556108C82248 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic push handler server | 2025/04/30 11:28:02 [debug] 22#0: *4 posix_memalign: 0000556108CCCD50:512 @16 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic output init packet max:1200 min:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic frame tx init:0 ACK n:0 delay:0 0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic frame tx init:0 CRYPTO len:123 off:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet tx init bytes:132 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic output hs packet max:1013 min:1013 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic frame tx hs:0 CRYPTO len:719 off:0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic packet tx hs bytes:959 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 11:28:02 [debug] 22#0: *4 sendmsg: 1200 of 1200 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic congestion send if:187 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic congestion send if:1200 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic congestion send if:1200 server | 2025/04/30 11:28:02 [debug] 22#0: *4 event timer: 6, old: 315676, new: 315676 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic lost timer pto:997 server | 2025/04/30 11:28:02 [debug] 22#0: *4 event timer add: 6: 997:256673 server | 2025/04/30 11:28:02 [debug] 22#0: *4 quic state: send:60000 pto:997 close:60000 server | 2025/04/30 11:28:02 [debug] 22#0: worker cycle server | 2025/04/30 11:28:02 [debug] 22#0: epoll timer: 997 server | 2025/04/30 11:28:03 [debug] 22#0: timer delta: 1000 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 256673 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic pto timer server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic pto init pto_count:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic sendto init packet max:1200 min:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx init:1 PING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx init bytes:3 need_ack:0 number:1 encoded nl:1 trunc:0x1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 57 of 57 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:1257 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 0:256676 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic sendto init packet max:1200 min:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx init:2 PING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx init bytes:3 need_ack:0 number:2 encoded nl:1 trunc:0x2 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 57 of 57 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:1314 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 256676 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 0:256676 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic pto hs pto_count:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 posix_memalign: 0000556108CCCF60:512 @16 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic sendto hs packet max:1200 min:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx hs:1 PING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx hs bytes:3 need_ack:0 number:1 encoded nl:1 trunc:0x1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 56 of 56 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:1370 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 256676 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:997 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 997:257673 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic sendto hs packet max:1200 min:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx hs:2 PING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx hs bytes:3 need_ack:0 number:2 encoded nl:1 trunc:0x2 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 56 of 56 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:1426 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 257673 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:997 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 997:257673 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 257673 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:1994 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 1994:258670 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: send:59000 pto:1994 close:59000 server | 2025/04/30 11:28:03 [debug] 22#0: worker cycle server | 2025/04/30 11:28:03 [debug] 22#0: epoll timer: 1994 server | 2025/04/30 11:28:03 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:03 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic recvmsg: fd:6 n:1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx long flags:c8 version:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx init len:1174 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx dcid len:8 ba6223983084c835 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx scid len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic address validation token len:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx clearflags:c0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx number:1 len:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet len:1200 via sock seq:-1 path seq:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 status tx:1426 rx:2400 valid:0 st:0 mtu:1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame rx init:1 CRYPTO len:257 off:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic resend packet pnum:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion lost recovery win:131054 ss:-1 if:1239 server | 2025/04/30 11:28:03 [debug] 22#0: *4 post event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic resend packet pnum:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion lost recovery win:131054 ss:-1 if:226 server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic resend packet pnum:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion lost win:131054 ss:131054 if:170 server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic resend packet pnum:2 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion lost recovery win:131054 ss:131054 if:114 server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame rx init:1 PADDING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:1 largest 0 fr:0 nranges:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet done rc:0 level:init decr:1 pn:1 perr:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 315676 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 60000:316684 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: read:60000 pto:1986 close:58992 server | 2025/04/30 11:28:03 [debug] 22#0: timer delta: 8 server | 2025/04/30 11:28:03 [debug] 22#0: posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 delete posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic push handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic output init packet max:1200 min:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx init:3 ACK n:0 delay:0 1-0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx init:3 CRYPTO len:123 off:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx init bytes:132 need_ack:1 number:3 encoded nl:1 trunc:0x3 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic output hs packet max:1013 min:1013 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx hs:3 CRYPTO len:719 off:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx hs bytes:959 need_ack:1 number:3 encoded nl:1 trunc:0x3 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 1200 of 1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:301 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:1314 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:1314 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer: 6, old: 316684, new: 316684 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 258670 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:1994 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 1994:258678 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: send:60000 pto:1994 close:58992 server | 2025/04/30 11:28:03 [debug] 22#0: worker cycle server | 2025/04/30 11:28:03 [debug] 22#0: epoll timer: 1994 server | 2025/04/30 11:28:03 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:03 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic recvmsg: fd:6 n:1201 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx long flags:ce version:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx init len:1163 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx scid len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic address validation token len:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx clearflags:c0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx number:2 len:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet len:1201 via sock seq:0 path seq:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 status tx:2626 rx:3601 valid:0 st:0 mtu:1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame rx init:2 ACK n:0 delay:0 0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic updated largest received ack:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 258678 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:1466 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 1466:258678 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame rx init:2 PADDING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:2 largest 1 fr:1 nranges:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet done rc:0 level:init decr:1 pn:2 perr:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 316684 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 60000:317212 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: read:60000 pto:1466 close:58464 server | 2025/04/30 11:28:03 [debug] 22#0: timer delta: 528 server | 2025/04/30 11:28:03 [debug] 22#0: worker cycle server | 2025/04/30 11:28:03 [debug] 22#0: epoll timer: 1466 server | 2025/04/30 11:28:03 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:03 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic recvmsg: fd:6 n:92 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx long flags:eb version:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx hs len:56 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx scid len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx clearflags:e0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx number:0 len:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet len:92 via sock seq:0 path seq:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 status tx:2626 rx:3693 valid:0 st:0 mtu:1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion ack recovery win:131054 ss:131054 if:1257 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion ack recovery win:131054 ss:131054 if:1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion ack recovery win:131054 ss:131054 if:1013 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic socket seq:-1 closed nsock:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 258678 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:441 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 441:257681 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 in handshake tx:2626 rx:3693 valid:1 st:0 mtu:1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 post event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame rx hs:0 CRYPTO len:36 off:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_set_read_secret() level:3 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_add_handshake_data server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_flush_flight() server | 2025/04/30 11:28:03 [debug] 22#0: *4 SSL_do_handshake: 1 server | 2025/04/30 11:28:03 [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 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 post event 0000556108C823C8 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion ack recovery win:131054 ss:131054 if:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 257681 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer unset server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 schedule mtu:1500 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 100:257340 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic create sockets has:1 max:2 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic socket seq:1 listening at sid:000000000000200111212c048ef38c33f6b7540b nsock:2 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stateless reset token c819408170b7b409c951ef2605c76096 server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic init streams server | 2025/04/30 11:28:03 [debug] 22#0: *4 http3 init server | 2025/04/30 11:28:03 [debug] 22#0: *4 http3 init session server | 2025/04/30 11:28:03 [debug] 22#0: *4 posix_memalign: 0000556108C76250:512 @16 server | 2025/04/30 11:28:03 [debug] 22#0: *4 add cleanup: 0000556108C78310 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 75000:332240 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 315676 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet done rc:0 level:hs decr:1 pn:0 perr:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer: 6, old: 317212, new: 317240 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: read:59972 server | 2025/04/30 11:28:03 [debug] 22#0: timer delta: 28 server | 2025/04/30 11:28:03 [debug] 22#0: posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 delete posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic push handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic output app packet max:1200 min:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:0 CRYPTO len:572 off:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:0 HANDSHAKE DONE server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:0 NEW_CONNECTION_ID seq:1 retire:0 len:20 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx app bytes:617 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 643 of 643 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:643 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer: 6, old: 317212, new: 317240 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:1022 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 1022:258262 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: send:59972 pto:1022 server | 2025/04/30 11:28:03 [debug] 22#0: posted event 0000556108C823C8 server | 2025/04/30 11:28:03 [debug] 22#0: *4 delete posted event 0000556108C823C8 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic key update server | 2025/04/30 11:28:03 [debug] 22#0: worker cycle server | 2025/04/30 11:28:03 [debug] 22#0: epoll timer: 100 server | 2025/04/30 11:28:03 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:03 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic recvmsg: fd:6 n:58 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx long flags:e8 version:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx hs len:22 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx scid len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:03 [info] 22#0: *4 quic no hs keys, ignoring packet while decrypting packet, client: 193.167.0.100, server: 0.0.0.0:443 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet done rc:-5 level:hs decr:0 pn:0 perr:0 server | 2025/04/30 11:28:03 [debug] 22#0: timer delta: 2 server | 2025/04/30 11:28:03 [debug] 22#0: worker cycle server | 2025/04/30 11:28:03 [debug] 22#0: epoll timer: 98 server | 2025/04/30 11:28:03 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:03 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic recvmsg: fd:6 n:59 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx short flags:55 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx clearflags:40 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet rx number:0 len:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet len:59 via sock seq:0 path seq:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 status tx:3269 rx:3752 valid:1 st:2 mtu:1200 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame rx app:0 STREAM id:0x0 off:0 len:17 fin:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 is missing server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 create server | 2025/04/30 11:28:03 [debug] 22#0: *4 posix_memalign: 0000556108C76460:512 @16 server | 2025/04/30 11:28:03 [debug] 22#0: *4 posix_memalign: 0000556108CCD9E0:16384 @16 server | 2025/04/30 11:28:03 [debug] 22#0: *4 reusable connection: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 add cleanup: 0000556108CCDAA0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 post event 0000556108C9CAD0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 flow control msd:17/65536 md:17/8585216 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:0 largest -1 fr:0 nranges:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 post event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:0 perr:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer: 6, old: 317212, new: 317253 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: read:59959 pto:1009 server | 2025/04/30 11:28:03 [debug] 22#0: timer delta: 11 server | 2025/04/30 11:28:03 [debug] 22#0: posted event 0000556108C9CAD0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 delete posted event 0000556108C9CAD0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 quic init stream server | 2025/04/30 11:28:03 [debug] 22#0: *5 http3 init request stream server | 2025/04/30 11:28:03 [debug] 22#0: *5 add cleanup: 0000556108CCDB10 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 332240 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http wait request handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 recv buf:1024 server | 2025/04/30 11:28:03 [debug] 22#0: *5 quic stream id:0x0 recv len:17 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 flow update 17 server | 2025/04/30 11:28:03 [debug] 22#0: *5 reusable connection: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 posix_memalign: 0000556108CD19F0:4096 @16 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http process request line server | 2025/04/30 11:28:03 [debug] 22#0: *5 http request line: "GET /pmsewxdjvw" server | 2025/04/30 11:28:03 [debug] 22#0: *5 http uri: "/pmsewxdjvw" server | 2025/04/30 11:28:03 [debug] 22#0: *5 http args: "" server | 2025/04/30 11:28:03 [debug] 22#0: *5 http exten: "" server | 2025/04/30 11:28:03 [debug] 22#0: *5 rewrite phase: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 test location: "/" server | 2025/04/30 11:28:03 [debug] 22#0: *5 using configuration "/" server | 2025/04/30 11:28:03 [debug] 22#0: *5 http cl:-1 max:1048576 server | 2025/04/30 11:28:03 [debug] 22#0: *5 rewrite phase: 2 server | 2025/04/30 11:28:03 [debug] 22#0: *5 post rewrite phase: 3 server | 2025/04/30 11:28:03 [debug] 22#0: *5 generic phase: 4 server | 2025/04/30 11:28:03 [debug] 22#0: *5 generic phase: 5 server | 2025/04/30 11:28:03 [debug] 22#0: *5 access phase: 6 server | 2025/04/30 11:28:03 [debug] 22#0: *5 access phase: 7 server | 2025/04/30 11:28:03 [debug] 22#0: *5 post access phase: 8 server | 2025/04/30 11:28:03 [debug] 22#0: *5 generic phase: 9 server | 2025/04/30 11:28:03 [debug] 22#0: *5 generic phase: 10 server | 2025/04/30 11:28:03 [debug] 22#0: *5 content phase: 11 server | 2025/04/30 11:28:03 [debug] 22#0: *5 content phase: 12 server | 2025/04/30 11:28:03 [debug] 22#0: *5 content phase: 13 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http filename: "/www/pmsewxdjvw" server | 2025/04/30 11:28:03 [debug] 22#0: *5 add cleanup: 0000556108CD2728 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http static fd: 3 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http set discard body server | 2025/04/30 11:28:03 [debug] 22#0: *5 http output filter "/pmsewxdjvw?" server | 2025/04/30 11:28:03 [debug] 22#0: *5 http copy filter: "/pmsewxdjvw?" server | 2025/04/30 11:28:03 [debug] 22#0: *5 posix_memalign: 0000556108CD2A00:4096 @16 server | 2025/04/30 11:28:03 [debug] 22#0: *5 read: 3, 0000556108CD2A20, 1024, 0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http postpone filter "/pmsewxdjvw?" 0000556108CD2940 server | 2025/04/30 11:28:03 [debug] 22#0: *5 write new buf t:1 f:0 0000556108CD2A20, pos 0000556108CD2A20, size: 1024 file: 0, size: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http write filter: l:1 f:0 s:1024 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http write filter limit 2097152 server | 2025/04/30 11:28:03 [debug] 22#0: *4 malloc: 0000556108CD3A10:4096 server | 2025/04/30 11:28:03 [debug] 22#0: *5 quic send_chain sent:1024 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 flush limit:250000 server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 flush len:1024 last:0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http write filter 0000000000000000 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http copy filter: 0 "/pmsewxdjvw?" server | 2025/04/30 11:28:03 [debug] 22#0: *5 http finalize request: 0, "/pmsewxdjvw?" a:1, c:1 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http request count:1 blk:0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 http close request server | 2025/04/30 11:28:03 [debug] 22#0: *5 http log handler server | 193.167.0.100 - - [30/Apr/2025:11:28:03 +0000] "GET /pmsewxdjvw" 200 1024 "-" "-" server | 2025/04/30 11:28:03 [debug] 22#0: *5 run cleanup: 0000556108CD2728 server | 2025/04/30 11:28:03 [debug] 22#0: *5 file cleanup: fd:3 server | 2025/04/30 11:28:03 [debug] 22#0: *5 free: 0000556108CD19F0, unused: 64 server | 2025/04/30 11:28:03 [debug] 22#0: *5 free: 0000556108CD2A00, unused: 2925 server | 2025/04/30 11:28:03 [debug] 22#0: *5 close http connection: 6 server | 2025/04/30 11:28:03 [debug] 22#0: *5 reusable connection: 0 server | 2025/04/30 11:28:03 [debug] 22#0: *5 run cleanup: 0000556108CCDB10 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 75000:332253 server | 2025/04/30 11:28:03 [debug] 22#0: *5 run cleanup: 0000556108CCDAA0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 cleanup server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 send shutdown server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 flush limit:248976 server | 2025/04/30 11:28:03 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic stream id:0x0 flush len:0 last:1 server | 2025/04/30 11:28:03 [debug] 22#0: *5 free: 0000556108CCD9E0, unused: 14952 server | 2025/04/30 11:28:03 [debug] 22#0: posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 delete posted event 0000556108C82248 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic push handler server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic output app packet max:1200 min:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:1 ACK n:0 delay:0 0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:1 STREAM id:0x0 off:0 len:1024 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:1 STREAM id:0x0 off:1024 len:0 fin:1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx app bytes:1039 need_ack:1 number:1 encoded nl:1 trunc:0x1 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 1065 of 1065 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:643 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:643 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:1708 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer: 6, old: 317212, new: 317253 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 258262 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:1022 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 1022:258275 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic state: send:59959 pto:1022 server | 2025/04/30 11:28:03 [debug] 22#0: worker cycle server | 2025/04/30 11:28:03 [debug] 22#0: epoll timer: 87 server | 2025/04/30 11:28:03 [debug] 22#0: timer delta: 88 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 257340 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 send probe mtu:1500 pnum:2 tries:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic sendto app packet max:1500 min:1500 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:2 PING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx app bytes:1474 need_ack:0 number:2 encoded nl:1 trunc:0x2 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 rejected mtu:1500 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic path seq:0 send probe mtu:1350 pnum:3 tries:0 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic sendto app packet max:1350 min:1350 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic frame tx app:3 PING server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic packet tx app bytes:1324 need_ack:0 number:3 encoded nl:1 trunc:0x3 server | 2025/04/30 11:28:03 [debug] 22#0: *4 sendmsg: 1350 of 1350 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic congestion send if:3058 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer del: 6: 258275 server | 2025/04/30 11:28:03 [debug] 22#0: *4 quic lost timer pto:1022 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 1022:258363 server | 2025/04/30 11:28:03 [debug] 22#0: *4 event timer add: 6: 1022:258363 server | 2025/04/30 11:28:03 [debug] 22#0: worker cycle server | 2025/04/30 11:28:03 [debug] 22#0: epoll timer: 1022 client | 28:03.829 Discarding packet (57 bytes) that cannot be decrypted (Missing keys for encryption level Initial (keys discarded)) client | 28:03.829 Discarding packet (57 bytes) that cannot be decrypted (Missing keys for encryption level Initial (keys discarded)) client | 28:03.836 Discarding packet (1200 bytes) that cannot be decrypted (Missing keys for encryption level Initial (keys discarded)) client | Get requested finished in 3.24 sec (0.00 MB/s) : tech.kwik.h09.client.HttpResponseImpl@2ddc8ecb client | 28:04.424 Closing ClientConnection[ba6223983084c835/aa9658aaabc704a8(V1) with server4/193.167.100.100:443] (reason: ImmediateClose) server | 2025/04/30 11:28:04 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:04 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic recvmsg: fd:6 n:58 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx long flags:e7 version:1 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx hs len:22 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx scid len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:04 [info] 22#0: *4 quic no hs keys, ignoring packet while decrypting packet, client: 193.167.0.100, server: 0.0.0.0:443 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet done rc:-5 level:hs decr:0 pn:0 perr:0 server | 2025/04/30 11:28:04 [debug] 22#0: timer delta: 838 server | 2025/04/30 11:28:04 [debug] 22#0: worker cycle server | 2025/04/30 11:28:04 [debug] 22#0: epoll timer: 184 server | 2025/04/30 11:28:04 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:04 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic recvmsg: fd:6 n:58 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx long flags:e1 version:1 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx hs len:22 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet rx scid len:8 aa9658aaabc704a8 server | 2025/04/30 11:28:04 [info] 22#0: *4 quic no hs keys, ignoring packet while decrypting packet, client: 193.167.0.100, server: 0.0.0.0:443 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet done rc:-5 level:hs decr:0 pn:0 perr:0 server | 2025/04/30 11:28:04 [debug] 22#0: timer delta: 1 server | 2025/04/30 11:28:04 [debug] 22#0: worker cycle server | 2025/04/30 11:28:04 [debug] 22#0: epoll timer: 183 server | 2025/04/30 11:28:04 [debug] 22#0: timer delta: 183 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer del: 6: 258363 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic pto timer server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic pto app pto_count:0 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic sendto app packet max:1200 min:0 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic frame tx app:4 PING server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet tx app bytes:3 need_ack:0 number:4 encoded nl:1 trunc:0x4 server | 2025/04/30 11:28:04 [debug] 22#0: *4 sendmsg: 29 of 29 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic congestion send if:3087 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic lost timer pto:1022 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer add: 6: 1022:259385 server | 2025/04/30 11:28:04 [debug] 22#0: *4 posix_memalign: 0000556108C76670:512 @16 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic sendto app packet max:1200 min:0 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic frame tx app:5 PING server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet tx app bytes:3 need_ack:0 number:5 encoded nl:1 trunc:0x5 server | 2025/04/30 11:28:04 [debug] 22#0: *4 sendmsg: 29 of 29 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic congestion send if:3116 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer del: 6: 259385 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic lost timer pto:1022 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer add: 6: 1022:259385 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer del: 6: 259385 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic lost timer pto:2044 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer add: 6: 2044:260407 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic state: send:58849 pto:2044 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer del: 6: 258363 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic path seq:0 send probe mtu:1350 pnum:6 tries:1 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic sendto app packet max:1350 min:1350 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic frame tx app:6 PING server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic packet tx app bytes:1324 need_ack:0 number:6 encoded nl:1 trunc:0x6 server | 2025/04/30 11:28:04 [debug] 22#0: *4 sendmsg: 1350 of 1350 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic congestion send if:4466 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer del: 6: 260407 server | 2025/04/30 11:28:04 [debug] 22#0: *4 quic lost timer pto:2044 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer add: 6: 2044:260407 server | 2025/04/30 11:28:04 [debug] 22#0: *4 event timer add: 6: 2044:260407 server | 2025/04/30 11:28:04 [debug] 22#0: worker cycle server | 2025/04/30 11:28:04 [debug] 22#0: epoll timer: 2044 server | 2025/04/30 11:28:05 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:05 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic recvmsg: fd:6 n:44 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx short flags:4c server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx clearflags:40 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx number:1 len:1 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet len:44 via sock seq:0 path seq:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic path seq:0 status tx:7092 rx:3796 valid:1 st:3 mtu:1200 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic frame rx app:1 ACK n:0 delay:1375 1-0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic congestion avoidance win:131375 ss:131054 if:3823 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic congestion avoidance win:131906 ss:131054 if:2758 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic ngx_quic_drop_ack_ranges pn:0 largest:0 fr:0 nranges:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic stream id:0x0 ack len:1024 fin:0 unacked:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic stream id:0x0 ack len:0 fin:1 unacked:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic stream id:0x0 close server | 2025/04/30 11:28:05 [debug] 22#0: *4 reusable connection: 1 server | 2025/04/30 11:28:05 [debug] 22#0: *4 post event 0000556108C82248 server | 2025/04/30 11:28:05 [debug] 22#0: *4 update posted event 0000556108C82248 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic updated largest received ack:1 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic rtt sample latest:1504 min:1504 avg:1504 var:752 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer del: 6: 260407 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic lost timer pto:4143 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer add: 6: 4143:262900 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:1 largest -1 fr:0 nranges:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:1 perr:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer del: 6: 317212 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer add: 6: 60000:318757 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic state: read:60000 pto:4143 server | 2025/04/30 11:28:05 [debug] 22#0: timer delta: 394 server | 2025/04/30 11:28:05 [debug] 22#0: posted event 0000556108C82248 server | 2025/04/30 11:28:05 [debug] 22#0: *4 delete posted event 0000556108C82248 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic push handler server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic output app packet max:1200 min:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic frame tx app:7 MAX_STREAMS limit:129 bidi:1 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet tx app bytes:3 need_ack:1 number:7 encoded nl:1 trunc:0x7 server | 2025/04/30 11:28:05 [debug] 22#0: *4 sendmsg: 29 of 29 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic congestion send if:2758 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic congestion send if:2758 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic congestion send if:2787 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer: 6, old: 318757, new: 318757 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer del: 6: 262900 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic lost timer pto:4537 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer add: 6: 4537:263294 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic state: send:60000 pto:4537 server | 2025/04/30 11:28:05 [debug] 22#0: worker cycle server | 2025/04/30 11:28:05 [debug] 22#0: epoll timer: 1650 server | 2025/04/30 11:28:05 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:05 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic recvmsg: fd:6 n:47 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx short flags:44 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx clearflags:40 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx number:2 len:1 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet len:47 via sock seq:0 path seq:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic path seq:0 status tx:7121 rx:3843 valid:1 st:3 mtu:1200 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic frame rx app:2 CONNECTION_CLOSE err:0 ft:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic frame rx app:2 ACK n:0 delay:0 1-0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer del: 6: 263294 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic lost timer pto:4518 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer add: 6: 4518:263294 server | 2025/04/30 11:28:05 [debug] 22#0: *4 post event 0000556108C82308 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic ngx_quic_ack_packet pn:2 largest 1 fr:0 nranges:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:2 perr:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer: 6, old: 318757, new: 318776 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic state: draining read:59981 pto:4518 server | 2025/04/30 11:28:05 [debug] 22#0: timer delta: 19 server | 2025/04/30 11:28:05 [debug] 22#0: posted event 0000556108C82308 server | 2025/04/30 11:28:05 [debug] 22#0: *4 delete posted event 0000556108C82308 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic close handler server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic close initiated rc:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic close immediate term:0 drain:1 error:1 "" server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer add: 6: 13611:272387 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer del: 6: 263294 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer del: 6: 260407 server | 2025/04/30 11:28:05 [debug] 22#0: worker cycle server | 2025/04/30 11:28:05 [debug] 22#0: epoll timer: 13611 server | 2025/04/30 11:28:05 [debug] 22#0: epoll: fd:6 ev:0001 d:00007F696E160108 server | 2025/04/30 11:28:05 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic recvmsg: fd:6 n:47 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic input handler server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx short flags:56 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx dcid len:20 00000000000020011c1b61fd1a832c54abd3ea4e server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx clearflags:40 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet rx number:3 len:1 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet len:47 via sock seq:0 path seq:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic path seq:0 status tx:7121 rx:3890 valid:1 st:3 mtu:1200 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic packet done rc:0 level:app decr:1 pn:3 perr:0 server | 2025/04/30 11:28:05 [debug] 22#0: *4 event timer: 6, old: 318757, new: 318845 server | 2025/04/30 11:28:05 [debug] 22#0: *4 quic state: error:0 "connection is closing, packet discarded" closing draining read:59912 close:13542 server | 2025/04/30 11:28:05 [debug] 22#0: timer delta: 69 server | 2025/04/30 11:28:05 [debug] 22#0: worker cycle server | 2025/04/30 11:28:05 [debug] 22#0: epoll timer: 13542 client | Terminating Kwik client exited with code 0 Aborting on container exit... Container server Stopping Container client Stopping Container client Stopped Container server Stopped Container sim Stopping Container sim Stopped 2025-04-30 11:28:15,927 No key log file found. 2025-04-30 11:28:15,927 No key log file found. 2025-04-30 11:28:15,927 No key log file found. 2025-04-30 11:28:15,927 No key log file found. 2025-04-30 11:28:16,208 Check of downloaded files succeeded. 2025-04-30 11:28:17,336 Check of downloaded files succeeded.