2025-04-30 09:58:34,009 Generated random file: pdgylkzjch of size: 10240
2025-04-30 09:58:34,009 Requests: https://server4:443/pdgylkzjch
2025-04-30 09:58:34,068 
2025-04-30 09:58:34,069 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_jnwabnki/ TESTCASE_SERVER=retry TESTCASE_CLIENT=retry WWW=/tmp/www_p00iptm3/ DOWNLOADS=/tmp/download_80t9akik/ SERVER_LOGS=/tmp/logs_server_kuu1clly CLIENT_LOGS=/tmp/logs_client_5t2z8gcy SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=ghcr.io/ngtcp2/ngtcp2-interop:latest SERVER=ghcr.io/nginx/nginx-quic-qns:latest REQUESTS="https://server4:443/pdgylkzjch"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 09:58:46,147  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
client  | Setting up routes...
client  | Actual changes:
client  | tx-checksum-ip-generic: off
client  | tx-tcp-segmentation: off [not requested]
client  | tx-tcp-ecn-segmentation: off [not requested]
client  | tx-tcp-mangleid-segmentation: off [not requested]
client  | tx-tcp6-segmentation: off [not requested]
client  | tx-udp-segmentation: off [not requested]
client  | tx-checksum-sctp: off
client  | Endpoint's IPv4 address is 193.167.0.100
client  | Endpoint's IPv6 address is fd00:cafe:cafe::100
client  | wait-for-it.sh: waiting 30 seconds for sim:57832
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: retry
server  | 2025/04/30 09:58:34 [debug] 20#0: bind() 0.0.0.0:443 #5 
server  | 2025/04/30 09:58:34 [debug] 20#0: bind() 0.0.0.0:443 #6 
server  | 2025/04/30 09:58:34 [debug] 20#0: bind() [::]:443 #7 
server  | 2025/04/30 09:58:34 [debug] 20#0: bind() [::]:443 #8 
server  | 2025/04/30 09:58:34 [debug] 20#0: add cleanup: 000055DF2E7BC780
server  | 2025/04/30 09:58:34 [notice] 20#0: using the "epoll" event method
server  | 2025/04/30 09:58:34 [debug] 20#0: counter: 00007F1DD0C03080, 1
server  | 2025/04/30 09:58:34 [notice] 20#0: nginx/1.27.0 (9270:d1b8568f3042)
server  | 2025/04/30 09:58:34 [notice] 20#0: built by gcc 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2) 
server  | 2025/04/30 09:58:34 [notice] 20#0: OS: Linux 6.11.0-1012-azure
server  | 2025/04/30 09:58:34 [notice] 20#0: getrlimit(RLIMIT_NOFILE): 1048576:1048576
server  | 2025/04/30 09:58:34 [debug] 20#0: write: 9, 00007FFF1BC51E10, 3, 0
server  | 2025/04/30 09:58:34 [debug] 20#0: setproctitle: "nginx: master process /usr/sbin/nginx -c /etc/nginx/nginx.conf.retry"
server  | 2025/04/30 09:58:34 [notice] 20#0: start worker processes
server  | 2025/04/30 09:58:34 [debug] 20#0: channel 3:9
server  | 2025/04/30 09:58:34 [notice] 20#0: start worker process 21
server  | 2025/04/30 09:58:34 [debug] 20#0: sigsuspend
server  | 2025/04/30 09:58:34 [debug] 21#0: add cleanup: 000055DF2E7BC808
server  | 2025/04/30 09:58:34 [debug] 21#0: malloc: 000055DF2E7BF7D0:16
server  | 2025/04/30 09:58:34 [debug] 21#0: add cleanup: 000055DF2E7BC820
server  | 2025/04/30 09:58:34 [debug] 21#0: malloc: 000055DF2E7BDAD0:16
server  | 2025/04/30 09:58:34 [debug] 21#0: notify eventfd: 11
server  | 2025/04/30 09:58:34 [debug] 21#0: testing the EPOLLRDHUP flag: success
server  | 2025/04/30 09:58:34 [debug] 21#0: malloc: 000055DF2E7A5430:6144
server  | 2025/04/30 09:58:34 [debug] 21#0: malloc: 00007F1DD0575010:253952
server  | 2025/04/30 09:58:34 [debug] 21#0: malloc: 000055DF2E7C1890:98304
server  | 2025/04/30 09:58:34 [debug] 21#0: malloc: 000055DF2E7D98A0:98304
server  | 2025/04/30 09:58:34 [debug] 21#0: epoll add event: fd:5 op:1 ev:00002001
server  | 2025/04/30 09:58:34 [debug] 21#0: epoll add event: fd:6 op:1 ev:00002001
server  | 2025/04/30 09:58:34 [debug] 21#0: epoll add event: fd:7 op:1 ev:00002001
server  | 2025/04/30 09:58:34 [debug] 21#0: epoll add event: fd:8 op:1 ev:00002001
server  | 2025/04/30 09:58:34 [debug] 21#0: epoll add event: fd:9 op:1 ev:00002001
server  | 2025/04/30 09:58:34 [debug] 21#0: setproctitle: "nginx: worker process"
server  | 2025/04/30 09:58:34 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:34 [debug] 21#0: epoll timer: -1
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: posix_memalign: 000055DF2E7BDB30:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: malloc: 000055DF2E7BF7F0:1207
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic recvmsg: 193.167.100.2:42999 fd:6 n:1207
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic run
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic packet rx dcid len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic packet rx scid len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic address validation token len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 sending version negotiation packet
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 sendmsg: 11 of 11
sim     | server:443 is available after 1.018265871s
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 reusable connection: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 free: 000055DF2E7BF7F0
server  | 2025/04/30 09:58:35 [debug] 21#0: *1 free: 000055DF2E7BDB30, unused: 24
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 795
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: -1
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: posix_memalign: 000055DF2E7BDB30:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: malloc: 000055DF2E7BF7F0:1207
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic recvmsg: 193.167.100.2:42999 fd:6 n:1207
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic run
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic packet rx dcid len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic packet rx scid len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic address validation token len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 sending version negotiation packet
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 sendmsg: 11 of 11
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 reusable connection: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 free: 000055DF2E7BF7F0
server  | 2025/04/30 09:58:35 [debug] 21#0: *2 free: 000055DF2E7BDB30, unused: 24
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: -1
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: posix_memalign: 000055DF2E7BDB30:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: malloc: 000055DF2E7BF7F0:1207
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic recvmsg: 193.167.100.2:42999 fd:6 n:1207
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic run
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic packet rx long flags:c0 version:57414954
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic packet rx dcid len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic packet rx scid len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic address validation token len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 sending version negotiation packet
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 sendmsg: 11 of 11
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 reusable connection: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 free: 000055DF2E7BF7F0
server  | 2025/04/30 09:58:35 [debug] 21#0: *3 free: 000055DF2E7BDB30, unused: 24
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#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
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: posix_memalign: 000055DF2E7BDB30:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: malloc: 000055DF2E7BF7F0:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic recvmsg: 193.167.0.100:47252 fd:6 n:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic run
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic packet rx long flags:ce version:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic packet rx init len:1153
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic packet rx dcid len:18 09e69d6ef2d1f6c76e276a32ce735792d92b
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic packet rx scid len:17 c0fc08015f0995f7d0ac2711c730af252c
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic address validation token len:0 
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 sendmsg: 136 of 136
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic retry packet sent to c0fc08015f0995f7d0ac2711c730af252c
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic packet done rc:-4 level:init decr:0 pn:0 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 quic packet rejected rc:-4, cleanup connection
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 reusable connection: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 free: 000055DF2E7BF7F0
server  | 2025/04/30 09:58:35 [debug] 21#0: *4 free: 000055DF2E7BDB30, unused: 24
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 280
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: -1
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: posix_memalign: 000055DF2E7BDB30:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: malloc: 000055DF2E7BF7F0:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: 193.167.0.100:47252 fd:6 n:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic run
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx long flags:c0 version:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx init len:1074
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 eb03872ea39642ad7c51bf921052a3f608d4805d
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx scid len:17 c0fc08015f0995f7d0ac2711c730af252c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic address validation token len:76 c63affed20599fcccdc99603b70eab12a9eda8b2cbd0b008e5b3891e9b731f8b93fd580355d68f7730e318928486e06990f186e90e5409f75fb02574aff5ba76ae5de0075c87adbb17d56597
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E7A6EA0:2448
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E7A7840:1528
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7A7E40:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_set_initial_secret
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:0 listening at sid:0000000000003001f7808f1f45ca3d234a1aaf9c nsock:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic cid seq:0 received id:17:c0fc08015f0995f7d0ac2711c730af252c:00000000000000000000000000000000
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E79A9A0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 created addr:193.167.0.100:47252
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 set active tx:0 rx:0 valid:1 st:0 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E79ABB0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:-1 listening at sid:eb03872ea39642ad7c51bf921052a3f608d4805d nsock:2
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 reusable connection: 1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic connection created
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:c3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045904 len:4
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:1200 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:0 rx:1200 valid:1 st:0 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stateless reset token 3b3970f13bba67832783337650c633af
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E79BCE0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx init:1190045904 CRYPTO len:263 off:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 SSL server name: "server4"
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 SSL ALPN supported by client: hq-interop
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 SSL ALPN selected: hq-interop
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_add_handshake_data
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic SSL_get_peer_quic_transport_params(): params_len:59
server  | 2025/04/30 09:58:35 [info] 21#0: *5 quic unknown transport param id:0x2ab2, skipped while handling frames, client: 193.167.0.100, server: 0.0.0.0:443
server  | 2025/04/30 09:58:35 [info] 21#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 09:58:35 [debug] 21#0: *5 quic transport parameters parsed ok
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp disable active migration: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp idle_timeout:30000
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp max_udp_payload_size:65527
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp max_data:25165824
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp max_stream_data_bidi_local:16777216
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp max_stream_data_bidi_remote:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp max_stream_data_uni:16777216
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp initial_max_streams_bidi:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp initial_max_streams_uni:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp ack_delay_exponent:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp max_ack_delay:25
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp active_connection_id_limit:7
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic tp initial source_connection_id len:17 c0fc08015f0995f7d0ac2711c730af252c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E79C4E0:4096
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_set_write_secret() level:2
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_add_handshake_data
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E79E6A0:4096
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E79F6B0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_set_write_secret() level:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_flush_flight()
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_set_read_secret() level:2
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 SSL_do_handshake: -1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 SSL_get_error: 2
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx init:1190045904 PADDING
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045904 largest -1 fr:0 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:init decr:1 pn:1190045904 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 30000:348659
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 60000:378659
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:30000 close:60000
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 32
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output init packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx init:0 ACK n:0 delay:0 1190045904
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx init:0 CRYPTO len:90 off:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx init bytes:106 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output hs packet max:1030 min:1030
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx hs:0 CRYPTO len:751 off:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx hs bytes:967 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:170
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348659
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:997
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 997:319656
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: send:30000 pto:997 close:60000
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 997
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: fd:6 n:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic input handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx long flags:c5 version:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx init len:22
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx scid len:17 c0fc08015f0995f7d0ac2711c730af252c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic address validation token len:76 c63affed20599fcccdc99603b70eab12a9eda8b2cbd0b008e5b3891e9b731f8b93fd580355d68f7730e318928486e06990f186e90e5409f75fb02574aff5ba76ae5de0075c87adbb17d56597
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:c0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045905 len:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:1200 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:1200 rx:2400 valid:1 st:0 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx init:1190045905 ACK n:0 delay:0 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_handle_ack_frame level:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion ack recovery win:131054 ss:-1 if:1030
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_drop_ack_ranges pn:1190045904 largest:1190045904 fr:0 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic updated largest received ack:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic rtt sample latest:36 min:36 avg:36 var:18
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 319656
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:72
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 72:318767
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045905 largest -1 fr:0 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:init decr:1 pn:1190045905 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx long flags:e2 version:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx hs len:64
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx scid len:17 c0fc08015f0995f7d0ac2711c730af252c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:e3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045903 len:4
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:-1 closed nsock:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318767
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:72
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 72:318767
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx hs:1190045903 ACK n:0 delay:0 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_handle_ack_frame level:2
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion ack recovery win:131054 ss:-1 if:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic updated largest received ack:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic rtt sample latest:36 min:36 avg:36 var:14
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318767
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer unset
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx hs:1190045903 CRYPTO len:36 off:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_set_read_secret() level:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_add_handshake_data
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_flush_flight()
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 SSL_do_handshake: 1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 SSL: TLSv1.3, cipher: "TLS_AES_128_GCM_SHA256 Kx=GENERIC Au=GENERIC Enc=AESGCM(128) Mac=AEAD"
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A7628
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer unset
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 schedule mtu:2400
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 100:318795
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic create sockets has:1 max:7
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:1 listening at sid:0000000000003001c8caa68a4a11da1dbdac596f nsock:2
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stateless reset token db13cd827caf990a552ee5575d303eb8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E79B670:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:2 listening at sid:000000000000300182dfbc008a4869216c16413b nsock:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stateless reset token 83a6ba0961f5d590a7078597f9a98b4d
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E79B880:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:3 listening at sid:0000000000003001c25b9d264b6718897335e11b nsock:4
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stateless reset token 21fb0afc8e8806859842d3cf207fe427
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E79BA90:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:4 listening at sid:000000000000300109bf70266eb8278a5fdc4267 nsock:5
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stateless reset token a1c168d8be2a087f748b109816c9bc23
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F2880:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:5 listening at sid:0000000000003001dccf65074f98ed75797634ec nsock:6
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stateless reset token 021b8c19398581f88dbe938cfd187071
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F2A90:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic socket seq:6 listening at sid:0000000000003001c7f7df6373ceeaad7ee220f5 nsock:7
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stateless reset token 5251adde897092f02e12566a5f9ab766
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic init streams
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 http3 init
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 http3 init session
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F2CA0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 add cleanup: 000055DF2E79F880
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 75000:393695
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 378659
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045903 largest -1 fr:0 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:hs decr:1 pn:1190045903 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx short flags:5c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:43
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045903 len:4
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045903 NEW_CONNECTION_ID seq:1 retire:0 len:17
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic cid seq:1 received id:17:fca4b7f68417c8e582911159c8b1226d9f:7b01cbcf8323a5cee49678d90aa6a009
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045903 STREAM id:0x0 len:17 fin:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 is missing
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 create
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F2EB0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F30C0:16384 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 reusable connection: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 add cleanup: 000055DF2E7F3180
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 post event 000055DF2E7C1AD0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 flow control msd:17/65536 md:17/8585216
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E7F70D0:4096
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045903 PADDING
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045903 largest -1 fr:0 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:app decr:1 pn:1190045903 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348695
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29964
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 36
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A7628
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A7628
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic key update
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7C1AD0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 delete posted event 000055DF2E7C1AD0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 quic init stream
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http3 init request stream
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 add cleanup: 000055DF2E7F31F0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 393695
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http wait request handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 recv buf:1024
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 quic stream id:0x0 recv len:17
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 flow update 17
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 reusable connection: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 posix_memalign: 000055DF2E7F80E0:4096 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http process request line
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http request line: "GET /pdgylkzjch"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http uri: "/pdgylkzjch"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http args: ""
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http exten: ""
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 rewrite phase: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 test location: "/"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 using configuration "/"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http cl:-1 max:1048576
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 rewrite phase: 2
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 post rewrite phase: 3
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 generic phase: 4
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 generic phase: 5
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 access phase: 6
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 access phase: 7
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 post access phase: 8
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 generic phase: 9
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 generic phase: 10
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 content phase: 11
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 content phase: 12
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 content phase: 13
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http filename: "/www/pdgylkzjch"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 add cleanup: 000055DF2E7F8E18
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http static fd: 3
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http set discard body
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http output filter "/pdgylkzjch?"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http copy filter: "/pdgylkzjch?"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 malloc: 000055DF2E7F90F0:10240
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 read: 3, 000055DF2E7F90F0, 10240, 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http postpone filter "/pdgylkzjch?" 000055DF2E7F9030
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 write new buf t:1 f:0 000055DF2E7F90F0, pos 000055DF2E7F90F0, size: 10240 file: 0, size: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http write filter: l:1 f:0 s:10240
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http write filter limit 2097152
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E7FB900:4096
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7FC910:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E7FCB20:4096
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 malloc: 000055DF2E7FDB30:4096
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 quic send_chain sent:10240
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 flush limit:16777216
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 flush len:10240 last:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http write filter 0000000000000000
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http copy filter: 0 "/pdgylkzjch?"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http finalize request: 0, "/pdgylkzjch?" a:1, c:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http request count:1 blk:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http close request
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 http log handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 posix_memalign: 000055DF2E7FEB40:4096 @16
server  | 193.167.0.100 - - [30/Apr/2025:09:58:35 +0000] "GET /pdgylkzjch" 200 10240 "-" "-"
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 run cleanup: 000055DF2E7F8E18
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 file cleanup: fd:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 free: 000055DF2E7F90F0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 free: 000055DF2E7F80E0, unused: 48
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 free: 000055DF2E7FEB40, unused: 3949
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 close http connection: 6
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 reusable connection: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 run cleanup: 000055DF2E7F31F0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 75000:393695
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 run cleanup: 000055DF2E7F3180
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 cleanup
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 send shutdown
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 flush limit:16766976
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F80E0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 update posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 flush len:0 last:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *6 free: 000055DF2E7F30C0, unused: 14952
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 ACK n:0 delay:0 1190045903
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 CRYPTO len:572 off:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 HANDSHAKE DONE
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 NEW_TOKEN
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:1 retire:0 len:20
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:2 retire:0 len:20
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:3 retire:0 len:20
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:4 retire:0 len:20
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:5 retire:0 len:20
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 NEW_CONNECTION_ID seq:6 retire:0 len:20
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:10245 need:276 shrink:9969
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:0 STREAM id:0x0 off:0 len:271
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:0 encoded nl:1 trunc:0x0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:9975 need:1165 shrink:8810
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F82F0:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:1 STREAM id:0x0 off:271 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:1 encoded nl:1 trunc:0x1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:2400
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:8816 need:1165 shrink:7651
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:2 STREAM id:0x0 off:1430 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:2 encoded nl:1 trunc:0x2
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:2400
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:2400
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:3600
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:7657 need:1165 shrink:6492
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F8500:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:3 STREAM id:0x0 off:2589 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:3 encoded nl:1 trunc:0x3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:3600
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:3600
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:4800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:6498 need:1165 shrink:5333
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:4 STREAM id:0x0 off:3748 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:4 encoded nl:1 trunc:0x4
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:4800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:4800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:6000
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:5339 need:1165 shrink:4174
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F8710:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:5 STREAM id:0x0 off:4907 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:5 encoded nl:1 trunc:0x5
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:6000
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:6000
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:7200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:4180 need:1165 shrink:3015
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:6 STREAM id:0x0 off:6066 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:6 encoded nl:1 trunc:0x6
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:7200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:7200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:8400
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:3021 need:1165 shrink:1856
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F8920:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:7 STREAM id:0x0 off:7225 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:7 encoded nl:1 trunc:0x7
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:8400
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:8400
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:9600
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic split frame now:1862 need:1165 shrink:697
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:8 STREAM id:0x0 off:8384 len:1159
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:1165 need_ack:1 number:8 encoded nl:1 trunc:0x8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 1200 of 1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:9600
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:9600
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:10800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:9 STREAM id:0x0 off:9543 len:697
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:9 STREAM id:0x0 off:10240 len:0 fin:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:708 need_ack:1 number:9 encoded nl:1 trunc:0x9
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 743 of 743
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:10800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:10800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:11543
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348695
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:117
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 117:318812
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: send:29964 pto:117
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 100
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: fd:6 n:1406
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic input handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx short flags:41
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:43
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045904 len:4
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:1406 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:12743 rx:3806 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045904 PING
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045904 PADDING
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045904 largest 1190045903 fr:0 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:app decr:1 pn:1190045904 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348697
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29962 pto:115
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 2
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 25:318722
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29962 push:25 pto:115
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 25
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 25
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318722
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 posix_memalign: 000055DF2E7F8B30:512 @16
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic output app packet max:1200 min:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame tx app:10 ACK n:0 delay:3125 1190045904-1190045903
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet tx app bytes:13 need_ack:0 number:10 encoded nl:1 trunc:0xa
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 sendmsg: 48 of 48
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:11543
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:11543
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion send if:11543
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29937 pto:90
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 73
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: fd:6 n:43
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic input handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx short flags:4b
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:40
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045905 len:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:43 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:12791 rx:3849 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045905 ACK n:0 delay:6 1-0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:132254 ss:-1 if:10343
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_drop_ack_ranges pn:1190045903 largest:1190045904 fr:1 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:271 fin:0 unacked:9969
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:133454 ss:-1 if:9143
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:1159 fin:0 unacked:8810
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic updated largest received ack:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic rtt sample latest:34 min:34 avg:36 var:11
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318812
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:71
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 71:318800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045905 largest 1190045904 fr:0 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:app decr:1 pn:1190045905 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348729
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29930 pto:71
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 7
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29930 pto:71
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 66
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: fd:6 n:43
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic input handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx short flags:47
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:40
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045906 len:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:43 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:12791 rx:3892 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045906 ACK n:0 delay:5 3-0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:134654 ss:-1 if:7943
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:1159 fin:0 unacked:7651
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:135854 ss:-1 if:6743
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:1159 fin:0 unacked:6492
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic updated largest received ack:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic rtt sample latest:36 min:34 avg:36 var:9
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318800
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:61
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 61:318792
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045906 largest 1190045905 fr:1 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:app decr:1 pn:1190045906 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348731
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29928 pto:61
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 2
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29928 pto:61
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 61
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: fd:6 n:43
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic input handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx short flags:49
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:40
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045907 len:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:43 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:12791 rx:3935 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045907 ACK n:0 delay:6 5-0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:137054 ss:-1 if:5543
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:1159 fin:0 unacked:5333
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:138254 ss:-1 if:4343
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:1159 fin:0 unacked:4174
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic updated largest received ack:5
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic rtt sample latest:38 min:34 avg:36 var:7
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318792
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:51
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 51:318784
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045907 largest 1190045906 fr:2 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:app decr:1 pn:1190045907 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348733
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29926 pto:51
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 2
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29926 pto:51
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 51
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: fd:6 n:43
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic input handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx short flags:5e
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:40
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045908 len:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:43 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:12791 rx:3978 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045908 ACK n:0 delay:6 7-0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_handle_ack_frame level:3
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:139454 ss:-1 if:3143
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:1159 fin:0 unacked:3015
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic congestion slow start win:140654 ss:-1 if:1943
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 ack len:1159 fin:0 unacked:1856
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic updated largest received ack:7
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic rtt sample latest:40 min:34 avg:37 var:7
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318784
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic lost timer pto:50
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 50:318785
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045908 largest 1190045907 fr:3 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:app decr:1 pn:1190045908 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348735
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29924 pto:50
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 2
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A74A8
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic push handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: read:29924 pto:50
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 50
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll: fd:6 ev:0001 d:00007F1DD0575108
server  | 2025/04/30 09:58:35 [debug] 21#0: quic recvmsg on 0.0.0.0:443, ready: 0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic recvmsg: fd:6 n:42
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic input handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx short flags:46
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx dcid len:20 0000000000003001f7808f1f45ca3d234a1aaf9c
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx clearflags:40
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet rx number:1190045909 len:1
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet len:42 via sock seq:0 path seq:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic path seq:0 status tx:12791 rx:4020 valid:1 st:2 mtu:1200
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic frame rx app:1190045909 CONNECTION_CLOSE err:0 ft:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A7568
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic ngx_quic_ack_packet pn:1190045909 largest 1190045908 fr:4 nranges:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic packet done rc:0 level:app decr:1 pn:1190045909 perr:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer: 6, old: 348659, new: 348737
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic state: draining read:29922 pto:48
server  | 2025/04/30 09:58:35 [debug] 21#0: timer delta: 2
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A7568
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A7568
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic close handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic close initiated rc:0
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic close immediate term:0 drain:1 error:1 ""
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer add: 6: 270:319007
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic stream id:0x0 close
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 post event 000055DF2E7A7568
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318785
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 event timer del: 6: 318795
server  | 2025/04/30 09:58:35 [debug] 21#0: posted event 000055DF2E7A7568
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 delete posted event 000055DF2E7A7568
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic close handler
server  | 2025/04/30 09:58:35 [debug] 21#0: *5 quic close resumed rc:0
server  | 2025/04/30 09:58:35 [debug] 21#0: worker cycle
server  | 2025/04/30 09:58:35 [debug] 21#0: epoll timer: 270

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

2025-04-30 09:58:46,242 Using the client's key log file.
2025-04-30 09:58:46,251 
2025-04-30 09:58:46,251 Using the client's key log file.
2025-04-30 09:58:46,251 Using the client's key log file.
2025-04-30 09:58:46,259 
2025-04-30 09:58:46,260 Using the client's key log file.
2025-04-30 09:58:46,821 Check of downloaded files succeeded.
2025-04-30 09:58:47,391 Check of Retry succeeded. Token used: c63affed20599fcccdc99603b70eab12a9eda8b2cbd0b008e5b3891e9b731f8b93fd580355d68f7730e318928486e06990f186e90e5409f75fb02574aff5ba76ae5de0075c87adbb17d56597