2025-04-30 10:48:36,618 Generated random file: mwpldghwmq of size: 10240 2025-04-30 10:48:36,618 Requests: https://server4:443/mwpldghwmq 2025-04-30 10:48:36,677 2025-04-30 10:48:36,678 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_156zw9nh/ TESTCASE_SERVER=retry TESTCASE_CLIENT=retry WWW=/tmp/www_zilscbd_/ DOWNLOADS=/tmp/download_2wdl0rw_/ SERVER_LOGS=/tmp/logs_server_c7yitpi1 CLIENT_LOGS=/tmp/logs_client_bh_6ki3y SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=aiortc/aioquic-qns:latest SERVER=ghcr.io/nginx/nginx-quic-qns:latest REQUESTS="https://server4:443/mwpldghwmq" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 10:48:49,223 Container sim Created Container client Recreate Container server Recreate Container server Recreated Container client Recreated Attaching to client, server, sim sim | waiting 10s for server:443 server | Setting up routes... client | Setting up routes... server | Actual changes: server | tx-checksumming: off server | tx-checksum-ip-generic: off server | tx-checksum-sctp: off server | tcp-segmentation-offload: off server | tx-tcp-segmentation: off [requested on] server | tx-tcp-ecn-segmentation: off [requested on] server | tx-tcp-mangleid-segmentation: off [requested on] server | tx-tcp6-segmentation: off [requested on] server | tx-udp-segmentation: off [requested on] client | Actual changes: client | tx-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] server | Endpoint's IPv4 address is 193.167.100.100 client | Endpoint's IPv4 address is 193.167.0.100 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 client | Endpoint's IPv6 address is fd00:cafe:cafe::100 server | >>> Starting nginx server... 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: retry server | 2025/04/30 10:48:37 [debug] 21#0: bind() 0.0.0.0:443 #5 server | 2025/04/30 10:48:37 [debug] 21#0: bind() 0.0.0.0:443 #6 server | 2025/04/30 10:48:37 [debug] 21#0: bind() [::]:443 #7 server | 2025/04/30 10:48:37 [debug] 21#0: bind() [::]:443 #8 server | 2025/04/30 10:48:37 [debug] 21#0: add cleanup: 0000559473405780 server | 2025/04/30 10:48:37 [notice] 21#0: using the "epoll" event method server | 2025/04/30 10:48:37 [debug] 21#0: counter: 00007FB079799080, 1 server | 2025/04/30 10:48:37 [notice] 21#0: nginx/1.27.0 (9270:d1b8568f3042) server | 2025/04/30 10:48:37 [notice] 21#0: built by gcc 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2) server | 2025/04/30 10:48:37 [notice] 21#0: OS: Linux 6.11.0-1012-azure server | 2025/04/30 10:48:37 [notice] 21#0: getrlimit(RLIMIT_NOFILE): 1048576:1048576 server | 2025/04/30 10:48:37 [debug] 21#0: write: 9, 00007FFC063D0460, 3, 0 server | 2025/04/30 10:48:37 [debug] 21#0: setproctitle: "nginx: master process /usr/sbin/nginx -c /etc/nginx/nginx.conf.retry" server | 2025/04/30 10:48:37 [notice] 21#0: start worker processes server | 2025/04/30 10:48:37 [debug] 21#0: channel 3:9 server | 2025/04/30 10:48:37 [notice] 21#0: start worker process 22 server | 2025/04/30 10:48:37 [debug] 21#0: sigsuspend server | 2025/04/30 10:48:37 [debug] 22#0: add cleanup: 0000559473405808 server | 2025/04/30 10:48:37 [debug] 22#0: malloc: 00005594734087D0:16 server | 2025/04/30 10:48:37 [debug] 22#0: add cleanup: 0000559473405820 server | 2025/04/30 10:48:37 [debug] 22#0: malloc: 0000559473406AD0:16 server | 2025/04/30 10:48:37 [debug] 22#0: notify eventfd: 11 server | 2025/04/30 10:48:37 [debug] 22#0: testing the EPOLLRDHUP flag: success server | 2025/04/30 10:48:37 [debug] 22#0: malloc: 00005594733EE430:6144 server | 2025/04/30 10:48:37 [debug] 22#0: malloc: 00007FB07910B010:253952 server | 2025/04/30 10:48:37 [debug] 22#0: malloc: 000055947340A890:98304 server | 2025/04/30 10:48:37 [debug] 22#0: malloc: 00005594734228A0:98304 server | 2025/04/30 10:48:37 [debug] 22#0: epoll add event: fd:5 op:1 ev:00002001 server | 2025/04/30 10:48:37 [debug] 22#0: epoll add event: fd:6 op:1 ev:00002001 server | 2025/04/30 10:48:37 [debug] 22#0: epoll add event: fd:7 op:1 ev:00002001 server | 2025/04/30 10:48:37 [debug] 22#0: epoll add event: fd:8 op:1 ev:00002001 client | wait-for-it.sh: waiting 30 seconds for sim:57832 server | 2025/04/30 10:48:37 [debug] 22#0: epoll add event: fd:9 op:1 ev:00002001 server | 2025/04/30 10:48:37 [debug] 22#0: setproctitle: "nginx: worker process" server | 2025/04/30 10:48:37 [debug] 22#0: worker cycle server | 2025/04/30 10:48:37 [debug] 22#0: epoll timer: -1 sim | server:443 is available after 1.063771571s server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: posix_memalign: 0000559473406B30:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: malloc: 00005594734087F0:1207 server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic recvmsg: 193.167.100.2:44104 fd:6 n:1207 server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic run server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic packet rx dcid len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic packet rx scid len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic address validation token len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *1 sending version negotiation packet server | 2025/04/30 10:48:38 [debug] 22#0: *1 sendmsg: 11 of 11 server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *1 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 10:48:38 [debug] 22#0: *1 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *1 free: 00005594734087F0 server | 2025/04/30 10:48:38 [debug] 22#0: *1 free: 0000559473406B30, unused: 24 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 835 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: -1 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: posix_memalign: 0000559473406B30:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: malloc: 00005594734087F0:1207 server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic recvmsg: 193.167.100.2:44104 fd:6 n:1207 server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic run server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic packet rx dcid len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic packet rx scid len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic address validation token len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *2 sending version negotiation packet server | 2025/04/30 10:48:38 [debug] 22#0: *2 sendmsg: 11 of 11 server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *2 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 10:48:38 [debug] 22#0: *2 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *2 free: 00005594734087F0 server | 2025/04/30 10:48:38 [debug] 22#0: *2 free: 0000559473406B30, unused: 24 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 0 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: -1 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: posix_memalign: 0000559473406B30:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: malloc: 00005594734087F0:1207 server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic recvmsg: 193.167.100.2:44104 fd:6 n:1207 server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic run server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic packet rx long flags:c0 version:57414954 server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic packet rx dcid len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic packet rx scid len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic address validation token len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *3 sending version negotiation packet server | 2025/04/30 10:48:38 [debug] 22#0: *3 sendmsg: 11 of 11 server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *3 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 10:48:38 [debug] 22#0: *3 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *3 free: 00005594734087F0 server | 2025/04/30 10:48:38 [debug] 22#0: *3 free: 0000559473406B30, unused: 24 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 0 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: -1 sim | Using scenario: simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25 sim | tcpdump: listening on eth1, link-type EN10MB (Ethernet), snapshot length 262144 bytes sim | tcpdump: listening on eth0, link-type EN10MB (Ethernet), snapshot length 262144 bytes client | wait-for-it.sh: sim:57832 is available after 1 seconds client | Starting client server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: posix_memalign: 0000559473406B30:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: malloc: 00005594734087F0:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic recvmsg: 193.167.0.100:55911 fd:6 n:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic run server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic packet rx long flags:c6 version:1 server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic packet rx init len:504 server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic packet rx dcid len:8 468d197bc9044095 server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic packet rx scid len:8 047e9e82bce78c5d server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic address validation token len:0 server | 2025/04/30 10:48:38 [debug] 22#0: *4 sendmsg: 117 of 117 server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic retry packet sent to 047e9e82bce78c5d server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic packet done rc:-4 level:init decr:0 pn:0 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *4 quic packet rejected rc:-4, cleanup connection server | 2025/04/30 10:48:38 [debug] 22#0: *4 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *4 free: 00005594734087F0 server | 2025/04/30 10:48:38 [debug] 22#0: *4 free: 0000559473406B30, unused: 24 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 385 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: -1 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: posix_memalign: 0000559473406B30:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: malloc: 00005594734087F0:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: 193.167.0.100:55911 fd:6 n:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic run server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx long flags:cb version:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx init len:504 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 682701bf6269d6987cee090882bda9e847fdc35b server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx scid len:8 047e9e82bce78c5d server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic address validation token len:66 2e1af1af562006065599fdb7a7eb3de5c72a1f34c7c6e5e9ce4844bc5ad10d9533b5ff8f435d819eb8122a9ce511a6ac01d4166ca8bdf13c943802d6d5116fbc5a73 server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 00005594733EFEA0:2448 server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 00005594733F0840:1528 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733F0E40:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_set_initial_secret server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:0 listening at sid:0000000000000002fd1add062f5c5a947b4bd3b2 nsock:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic cid seq:0 received id:8:047e9e82bce78c5d:00000000000000000000000000000000 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733E39A0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 created addr:193.167.0.100:55911 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 set active tx:0 rx:0 valid:1 st:0 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733E3BB0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:-1 listening at sid:682701bf6269d6987cee090882bda9e847fdc35b nsock:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 reusable connection: 1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic connection created server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:c1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:1 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:1200 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:0 rx:1200 valid:1 st:0 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token 29b0ba0c786748332c98f46ec1855eb7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733E4CE0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx init:1 CRYPTO len:482 off:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL server name: "server4" server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL ALPN supported by client: hq-interop server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL ALPN selected: hq-interop server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_add_handshake_data server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic SSL_get_peer_quic_transport_params(): params_len:71 server | 2025/04/30 10:48:38 [info] 22#0: *5 quic unknown transport param id:0x11, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic transport parameters parsed ok server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp disable active migration: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp idle_timeout:60000 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp max_udp_payload_size:65527 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp max_data:1048576 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp max_stream_data_bidi_local:1048576 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp max_stream_data_bidi_remote:1048576 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp max_stream_data_uni:1048576 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp initial_max_streams_bidi:128 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp initial_max_streams_uni:128 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp ack_delay_exponent:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp max_ack_delay:25 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp active_connection_id_limit:8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic tp initial source_connection_id len:8 047e9e82bce78c5d server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 00005594733E5C70:4096 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_set_write_secret() level:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_add_handshake_data server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 000055947343A8B0:4096 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733E7D80:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_set_write_secret() level:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_flush_flight() server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_set_read_secret() level:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL_do_handshake: -1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL_get_error: 2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:1 largest -1 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:init decr:1 pn:1 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:0 server | 2025/04/30 10:48:38 [info] 22#0: *5 quic fixed bit is not set while parsing quic packet, client: 193.167.0.100, server: 0.0.0.0:443 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:-5 parse failed server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 60000:413757 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 60000:413757 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:60000 close:60000 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 34 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output init packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx init:0 ACK n:0 delay:0 1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx init:0 CRYPTO len:123 off:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx init bytes:132 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output hs packet max:1013 min:1013 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx hs:0 CRYPTO len:755 off:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx hs bytes:959 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:187 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413757 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:997 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 997:354754 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: send:60000 pto:997 close:60000 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 997 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx long flags:cc version:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx init len:24 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx scid len:8 047e9e82bce78c5d server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic address validation token len:66 2e1af1af562006065599fdb7a7eb3de5c72a1f34c7c6e5e9ce4844bc5ad10d9533b5ff8f435d819eb8122a9ce511a6ac01d4166ca8bdf13c943802d6d5116fbc5a73 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:c1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:2 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:1200 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:1200 rx:2400 valid:1 st:0 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx init:2 ACK n:0 delay:284 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_handle_ack_frame level:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion ack recovery win:131054 ss:-1 if:1013 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_drop_ack_ranges pn:1 largest:1 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic updated largest received ack:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic rtt sample latest:36 min:36 avg:36 var:18 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 354754 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:72 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 72:353865 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:2 largest -1 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:init decr:1 pn:2 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx long flags:e2 version:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx hs len:80 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx scid len:8 047e9e82bce78c5d server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:e1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:3 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:-1 closed nsock:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353865 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:72 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 72:353865 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx hs:3 ACK n:0 delay:284 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_handle_ack_frame level:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion ack recovery win:131054 ss:-1 if:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic updated largest received ack:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic rtt sample latest:36 min:36 avg:36 var:14 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353865 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer unset server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx hs:3 CRYPTO len:52 off:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_set_read_secret() level:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_add_handshake_data server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_flush_flight() server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL_do_handshake: 1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL: TLSv1.3, cipher: "TLS_AES_256_GCM_SHA384 Kx=GENERIC Au=GENERIC Enc=AESGCM(256) Mac=AEAD" server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F0628 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer unset server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 schedule mtu:2400 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 100:353893 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic create sockets has:1 max:8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:1 listening at sid:00000000000000023af31b8e296aace1ab60a90f nsock:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token 3660907982c86a4863b58ddbd7445e08 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733E4670:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:2 listening at sid:000000000000000261835f9827e4b60da88227de nsock:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token 892419884f6d9ca6cae2e75c5dca9ce9 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733E4880:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:3 listening at sid:0000000000000002c815a6ab76f6391c680a13f8 nsock:4 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token e7b2a2e321c2860ae6a0e451ecabdda8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594733E4A90:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:4 listening at sid:000000000000000252a725e984cb03d31b2ad954 nsock:5 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token 1a440289481f3163a409655a01c108d2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 000055947343C120:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:5 listening at sid:00000000000000026b1f53bb1d330af1d2587c1c nsock:6 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token 81452c14264eae2b333e67cbc713ab28 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 000055947343C330:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:6 listening at sid:00000000000000029e46d6829ed668cb5a0e7524 nsock:7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token 6fb86b6aed9a5fafc7bac7b2689ee424 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 000055947343C540:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:7 listening at sid:0000000000000002b4716d5f671883cccd7d4a31 nsock:8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stateless reset token f40fc3fe997e3f06fd87866ee3b55e3d server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic init streams server | 2025/04/30 10:48:38 [debug] 22#0: *5 http3 init server | 2025/04/30 10:48:38 [debug] 22#0: *5 http3 init session server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 000055947343C750:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 add cleanup: 00005594733E4828 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 75000:428793 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 413757 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:3 largest -1 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:hs decr:1 pn:3 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:5c server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:41 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:4 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:4 NEW_CONNECTION_ID seq:1 retire:0 len:8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic cid seq:1 received id:8:25153bc98c9fae35:8fd8c82e46cd6fe5a0d8dd85ee0716a6 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:4 PADDING server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:4 largest -1 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:4 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413793 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59964 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 36 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 000055947343C960:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 ACK n:0 delay:0 4 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 CRYPTO len:604 off:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 HANDSHAKE DONE server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_TOKEN server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:1 retire:0 len:20 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:2 retire:0 len:20 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:3 retire:0 len:20 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:4 retire:0 len:20 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:5 retire:0 len:20 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:6 retire:0 len:20 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:7 retire:0 len:20 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:954 need_ack:1 number:0 encoded nl:1 trunc:0x0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 980 of 980 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:980 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413793 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:117 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 117:353910 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: send:59964 pto:117 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F0628 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F0628 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic key update server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 100 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:60 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:4b server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:41 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:5 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:60 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:2180 rx:2460 valid:1 st:2 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:5 STREAM id:0x0 len:17 fin:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 is missing server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 create server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 000055947343CB70:16384 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 add cleanup: 000055947343CC30 server | 2025/04/30 10:48:38 [debug] 22#0: *6 post event 000055947340AAD0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 flow control msd:17/65536 md:17/8585216 server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 0000559473440B80:4096 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:5 largest 4 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:5 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413794 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59963 pto:116 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 1 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 000055947340AAD0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 delete posted event 000055947340AAD0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 quic init stream server | 2025/04/30 10:48:38 [debug] 22#0: *6 http3 init request stream server | 2025/04/30 10:48:38 [debug] 22#0: *6 add cleanup: 000055947343CCA0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 428793 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http wait request handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 recv buf:1024 server | 2025/04/30 10:48:38 [debug] 22#0: *6 quic stream id:0x0 recv len:17 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 flow update 17 server | 2025/04/30 10:48:38 [debug] 22#0: *6 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 posix_memalign: 0000559473441B90:4096 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http process request line server | 2025/04/30 10:48:38 [debug] 22#0: *6 http request line: "GET /mwpldghwmq" server | 2025/04/30 10:48:38 [debug] 22#0: *6 http uri: "/mwpldghwmq" server | 2025/04/30 10:48:38 [debug] 22#0: *6 http args: "" server | 2025/04/30 10:48:38 [debug] 22#0: *6 http exten: "" server | 2025/04/30 10:48:38 [debug] 22#0: *6 rewrite phase: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 test location: "/" server | 2025/04/30 10:48:38 [debug] 22#0: *6 using configuration "/" server | 2025/04/30 10:48:38 [debug] 22#0: *6 http cl:-1 max:1048576 server | 2025/04/30 10:48:38 [debug] 22#0: *6 rewrite phase: 2 server | 2025/04/30 10:48:38 [debug] 22#0: *6 post rewrite phase: 3 server | 2025/04/30 10:48:38 [debug] 22#0: *6 generic phase: 4 server | 2025/04/30 10:48:38 [debug] 22#0: *6 generic phase: 5 server | 2025/04/30 10:48:38 [debug] 22#0: *6 access phase: 6 server | 2025/04/30 10:48:38 [debug] 22#0: *6 access phase: 7 server | 2025/04/30 10:48:38 [debug] 22#0: *6 post access phase: 8 server | 2025/04/30 10:48:38 [debug] 22#0: *6 generic phase: 9 server | 2025/04/30 10:48:38 [debug] 22#0: *6 generic phase: 10 server | 2025/04/30 10:48:38 [debug] 22#0: *6 content phase: 11 server | 2025/04/30 10:48:38 [debug] 22#0: *6 content phase: 12 server | 2025/04/30 10:48:38 [debug] 22#0: *6 content phase: 13 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http filename: "/www/mwpldghwmq" server | 2025/04/30 10:48:38 [debug] 22#0: *6 add cleanup: 00005594734428C8 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http static fd: 3 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http set discard body server | 2025/04/30 10:48:38 [debug] 22#0: *6 http output filter "/mwpldghwmq?" server | 2025/04/30 10:48:38 [debug] 22#0: *6 http copy filter: "/mwpldghwmq?" server | 2025/04/30 10:48:38 [debug] 22#0: *6 malloc: 0000559473442BA0:10240 server | 2025/04/30 10:48:38 [debug] 22#0: *6 read: 3, 0000559473442BA0, 10240, 0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http postpone filter "/mwpldghwmq?" 0000559473442AE0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 write new buf t:1 f:0 0000559473442BA0, pos 0000559473442BA0, size: 10240 file: 0, size: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http write filter: l:1 f:0 s:10240 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http write filter limit 2097152 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594734453B0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 00005594734455C0:4096 server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 00005594734465D0:4096 server | 2025/04/30 10:48:38 [debug] 22#0: *5 malloc: 00005594734475E0:4096 server | 2025/04/30 10:48:38 [debug] 22#0: *6 quic send_chain sent:10240 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 flush limit:1048576 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 flush len:10240 last:0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http write filter 0000000000000000 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http copy filter: 0 "/mwpldghwmq?" server | 2025/04/30 10:48:38 [debug] 22#0: *6 http finalize request: 0, "/mwpldghwmq?" a:1, c:1 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http request count:1 blk:0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 http close request server | 2025/04/30 10:48:38 [debug] 22#0: *6 http log handler server | 2025/04/30 10:48:38 [debug] 22#0: *6 posix_memalign: 00005594734485F0:4096 @16 server | 193.167.0.100 - - [30/Apr/2025:10:48:38 +0000] "GET /mwpldghwmq" 200 10240 "-" "-" server | 2025/04/30 10:48:38 [debug] 22#0: *6 run cleanup: 00005594734428C8 server | 2025/04/30 10:48:38 [debug] 22#0: *6 file cleanup: fd:3 server | 2025/04/30 10:48:38 [debug] 22#0: *6 free: 0000559473442BA0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 free: 0000559473441B90, unused: 48 server | 2025/04/30 10:48:38 [debug] 22#0: *6 free: 00005594734485F0, unused: 3949 server | 2025/04/30 10:48:38 [debug] 22#0: *6 close http connection: 6 server | 2025/04/30 10:48:38 [debug] 22#0: *6 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *6 run cleanup: 000055947343CCA0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 75000:428794 server | 2025/04/30 10:48:38 [debug] 22#0: *6 run cleanup: 000055947343CC30 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 cleanup server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 send shutdown server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 flush limit:1038336 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 0000559473441B90:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 flush len:0 last:1 server | 2025/04/30 10:48:38 [debug] 22#0: *6 free: 000055947343CB70, unused: 14952 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:1 ACK n:0 delay:0 5-4 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:10245 need:1169 shrink:9076 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 0000559473441DA0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:1 STREAM id:0x0 off:0 len:1164 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:1 encoded nl:1 trunc:0x1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:980 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:980 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:2180 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:9082 need:1174 shrink:7908 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:2 STREAM id:0x0 off:1164 len:1168 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:2 encoded nl:1 trunc:0x2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:2180 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:2180 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:3380 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:7914 need:1174 shrink:6740 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 0000559473441FB0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:3 STREAM id:0x0 off:2332 len:1168 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:3 encoded nl:1 trunc:0x3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:3380 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:3380 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:4580 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:6746 need:1174 shrink:5572 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:4 STREAM id:0x0 off:3500 len:1168 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:4 encoded nl:1 trunc:0x4 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:4580 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:4580 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:5780 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:5578 need:1174 shrink:4404 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594734421C0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:5 STREAM id:0x0 off:4668 len:1168 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:5 encoded nl:1 trunc:0x5 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:5780 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:5780 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:6980 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:4410 need:1174 shrink:3236 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:6 STREAM id:0x0 off:5836 len:1168 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:6 encoded nl:1 trunc:0x6 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:6980 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:6980 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:8180 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:3242 need:1174 shrink:2068 server | 2025/04/30 10:48:38 [debug] 22#0: *5 posix_memalign: 00005594734423D0:512 @16 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:7 STREAM id:0x0 off:7004 len:1168 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:7 encoded nl:1 trunc:0x7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:8180 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:8180 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:9380 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic split frame now:2074 need:1174 shrink:900 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:8 STREAM id:0x0 off:8172 len:1168 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:1174 need_ack:1 number:8 encoded nl:1 trunc:0x8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 1200 of 1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:9380 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:9380 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:10580 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:9 STREAM id:0x0 off:9340 len:900 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:9 STREAM id:0x0 off:10240 len:0 fin:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:911 need_ack:1 number:9 encoded nl:1 trunc:0x9 server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 937 of 937 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:10580 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:10580 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:11517 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413794 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353910 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:117 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 117:353911 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: send:59963 pto:117 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 99 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:44 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:69 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:61 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:6 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:44 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:12717 rx:2504 valid:1 st:2 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:6 ACK n:0 delay:15 1-0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:132034 ss:-1 if:10537 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_drop_ack_ranges pn:4 largest:5 fr:1 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:133234 ss:-1 if:9337 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_drop_ack_ranges pn:5 largest:5 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1164 fin:0 unacked:9076 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic updated largest received ack:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic rtt sample latest:34 min:34 avg:36 var:11 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353911 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:71 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 71:353899 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:6 largest -1 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:6 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413828 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59929 pto:71 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 34 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59929 pto:71 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 65 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:44 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:7c server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:61 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:7 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:44 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:12717 rx:2548 valid:1 st:2 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:7 ACK n:0 delay:7 3-0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:134434 ss:-1 if:8137 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1168 fin:0 unacked:7908 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:135634 ss:-1 if:6937 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1168 fin:0 unacked:6740 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic updated largest received ack:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic rtt sample latest:36 min:34 avg:36 var:9 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353899 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:61 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 61:353891 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:7 largest 6 fr:0 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:7 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413830 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59927 pto:61 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 2 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59927 pto:61 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 61 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:44 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:7b server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:61 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:8 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:44 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:12717 rx:2592 valid:1 st:2 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:8 ACK n:0 delay:7 5-0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:136834 ss:-1 if:5737 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1168 fin:0 unacked:5572 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:138034 ss:-1 if:4537 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1168 fin:0 unacked:4404 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic updated largest received ack:5 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic rtt sample latest:38 min:34 avg:36 var:7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353891 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:51 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 51:353883 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:8 largest 7 fr:1 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:8 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413832 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59925 pto:51 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 2 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59925 pto:51 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 51 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:44 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:77 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:61 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:9 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:44 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:12717 rx:2636 valid:1 st:2 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:9 ACK n:0 delay:6 7-0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:139234 ss:-1 if:3337 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1168 fin:0 unacked:3236 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:140434 ss:-1 if:2137 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1168 fin:0 unacked:2068 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic updated largest received ack:7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic rtt sample latest:40 min:34 avg:37 var:7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353883 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:50 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 50:353884 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:9 largest 8 fr:2 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:9 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413834 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59923 pto:50 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 2 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59923 pto:50 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 50 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:44 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:7c server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:61 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:10 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:44 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:12717 rx:2680 valid:1 st:2 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:10 ACK n:0 delay:35 9-0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_handle_ack_frame level:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:141634 ss:-1 if:937 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:1168 fin:0 unacked:900 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion slow start win:142571 ss:-1 if:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:900 fin:0 unacked:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 ack len:0 fin:1 unacked:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic stream id:0x0 close server | 2025/04/30 10:48:38 [debug] 22#0: *5 reusable connection: 1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 update posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic updated largest received ack:9 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic rtt sample latest:42 min:34 avg:38 var:7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353884 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer unset server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:10 largest 9 fr:3 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:10 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413836 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: read:59921 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 2 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F04A8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic push handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic output app packet max:1200 min:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame tx app:10 MAX_STREAMS limit:129 bidi:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet tx app bytes:3 need_ack:1 number:10 encoded nl:1 trunc:0xa server | 2025/04/30 10:48:38 [debug] 22#0: *5 sendmsg: 29 of 29 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic congestion send if:29 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413836 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic lost timer pto:91 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 91:353927 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: send:59921 pto:91 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 57 server | 2025/04/30 10:48:38 [debug] 22#0: epoll: fd:6 ev:0001 d:00007FB07910B108 server | 2025/04/30 10:48:38 [debug] 22#0: quic recvmsg on 0.0.0.0:443, ready: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic recvmsg: fd:6 n:43 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic input handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx short flags:74 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx dcid len:20 0000000000000002fd1add062f5c5a947b4bd3b2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx clearflags:61 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet rx number:11 len:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet len:43 via sock seq:0 path seq:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic path seq:0 status tx:12746 rx:2723 valid:1 st:2 mtu:1200 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic frame rx app:11 CONNECTION_CLOSE_APP err:256 server | 2025/04/30 10:48:38 [debug] 22#0: *5 post event 00005594733F0568 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_ack_packet pn:11 largest 10 fr:4 nranges:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic packet done rc:0 level:app decr:1 pn:11 perr:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer: 6, old: 413757, new: 413836 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic state: draining read:59921 pto:91 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 0 server | 2025/04/30 10:48:38 [debug] 22#0: posted event 00005594733F0568 server | 2025/04/30 10:48:38 [debug] 22#0: *5 delete posted event 00005594733F0568 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic close handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic close initiated rc:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic close immediate term:0 drain:1 error:1 "" server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer add: 6: 273:354109 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353927 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 353893 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: 273 server | 2025/04/30 10:48:38 [debug] 22#0: timer delta: 274 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 354109 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic close handler server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic close resumed rc:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:0 closed nsock:7 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:1 closed nsock:6 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:2 closed nsock:5 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:3 closed nsock:4 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:4 closed nsock:3 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:5 closed nsock:2 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:6 closed nsock:1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic socket seq:7 closed nsock:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic close completed server | 2025/04/30 10:48:38 [debug] 22#0: *5 quic ngx_quic_send_alert() level:app alert:0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 SSL_shutdown: 1 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: 6: 413757 server | 2025/04/30 10:48:38 [debug] 22#0: *5 reusable connection: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 run cleanup: 00005594733E4828 server | 2025/04/30 10:48:38 [debug] 22#0: *5 event timer del: -1: 428794 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594734475E0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594734465D0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594734455C0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 0000559473440B80 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 000055947343A8B0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E5C70 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733F0840 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733EFEA0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594734087F0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 0000559473406B30, unused: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733F0E40, unused: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E39A0, unused: 56 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E3BB0, unused: 40 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E4CE0, unused: 48 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E7D80, unused: 48 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E4670, unused: 48 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E4880, unused: 40 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594733E4A90, unused: 8 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 000055947343C120, unused: 24 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 000055947343C330, unused: 40 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 000055947343C540, unused: 40 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 000055947343C750, unused: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 000055947343C960, unused: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594734453B0, unused: 0 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 0000559473441B90, unused: 32 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 0000559473441DA0, unused: 32 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 0000559473441FB0, unused: 32 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594734421C0, unused: 32 server | 2025/04/30 10:48:38 [debug] 22#0: *5 free: 00005594734423D0, unused: 192 server | 2025/04/30 10:48:38 [debug] 22#0: worker cycle server | 2025/04/30 10:48:38 [debug] 22#0: epoll timer: -1 client exited with code 0 Aborting on container exit... Container client Stopping Container server Stopping Container client Stopped Container server Stopped Container sim Stopping Container sim Stopped 2025-04-30 10:48:49,319 Using the client's key log file. 2025-04-30 10:48:49,328 2025-04-30 10:48:49,329 Using the client's key log file. 2025-04-30 10:48:49,329 Using the client's key log file. 2025-04-30 10:48:49,337 2025-04-30 10:48:49,338 Using the client's key log file. 2025-04-30 10:48:49,901 Check of downloaded files succeeded. 2025-04-30 10:48:50,472 Check of Retry succeeded. Token used: 2e1af1af562006065599fdb7a7eb3de5c72a1f34c7c6e5e9ce4844bc5ad10d9533b5ff8f435d819eb8122a9ce511a6ac01d4166ca8bdf13c943802d6d5116fbc5a73