search

alibaba / tengine

A distribution of Nginx with some advanced features
https://tengine.taobao.org
BSD 2-Clause "Simplified" License
12.83k stars 2.52k forks source link

请问tengine对xquic ssl的证书有要求吗？openssl生成的测试用证书是不是不行？ #1969

Open D-NanSheng opened 15 hours ago

D-NanSheng commented 15 hours ago

Question

以下是tengine-xquic.log的日志

2024/11/14 13:13:30.059|0000430511374[stats] |xqc_conn_server_init_path_addr|path:0|l-10.37.30.62-8000-b827812dc384226bd72ee328 p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7||
2024/11/14 13:13:30.059|0000430511374[connection_started] |scid:b827812dc384226bd72ee328|xqc_conn_server_create|remote|dst_ip:10.37.30.62|dst_port:32455|scid:b827812dc384226bd72ee328|dcid:770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7||
2024/11/14 13:13:32.386|0000430513701[report] |scid:b827812dc384226bd72ee328|xqc_conn_destroy|00005581BF9DC800|has_0rtt:0|0rtt_accept:0|token_ok:0|handshake_time:0|first_send_delay:0|conn_persist:2326520|keyupdate_cnt:0|err:0x150|close_msg:local error|l-10.37.30.62-8000-b827812dc384226bd72ee328 p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7|hsk_recv:0|close_recv:0|close_send:550|last_recv:1000890|last_send:1000992|mp_enable:0|create:1|validated:1|active:1|path_info:1,0,0,0,0,0,0-2,0-0,0-0,0-250000,0-150,0-1200,0-0,0-1,0-0,0-0,0-0,0-0,0-0,0-0|alpn:h3|
2024/11/14 13:13:32.386|0000430513701[connection_closed] |scid:b827812dc384226bd72ee328|xqc_conn_destroy|err_code:336||
2024/11/14 13:13:32.386|0000430513701[stats] |scid:b827812dc384226bd72ee328|xqc_destroy_stream|err:0x0|close_msg:conn closed|enable_multipath:0|send_state:0|recv_state:0|stream_id:3|stream_type:3|send_bytes:0|read_bytes:0|recv_bytes:0|stream_len:0|create_time:1731561210060358|wrt_delay:0|snd_delay:0|finwrt_delay:0|finsnd_delay:0|finrcv_delay:0|finread_delay:0|all_acked_delay:0|firstfinack_dely:0|close_delay:0|apprst_delay:0|rstsnd_delay:0|rstrcv_delay:0|l-10.37.30.62-8000-b827812dc384226bd72ee328 p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7|path_info:mp is not supported in connection scid:b827812dc384226bd72ee328||
2024/11/14 13:13:32.386|0000430513701[stats] |scid:b827812dc384226bd72ee328|xqc_destroy_stream|err:0x0|close_msg:conn closed|enable_multipath:0|send_state:0|recv_state:0|stream_id:7|stream_type:3|send_bytes:0|read_bytes:0|recv_bytes:0|stream_len:0|create_time:1731561210060381|wrt_delay:0|snd_delay:0|finwrt_delay:0|finsnd_delay:0|finrcv_delay:0|finread_delay:0|all_acked_delay:0|firstfinack_dely:0|close_delay:0|apprst_delay:0|rstsnd_delay:0|rstrcv_delay:0|l-10.37.30.62-8000-b827812dc384226bd72ee328 p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7|path_info:mp is not supported in connection scid:b827812dc384226bd72ee328||
2024/11/14 13:13:32.386|0000430513701[stats] |scid:b827812dc384226bd72ee328|xqc_destroy_stream|err:0x0|close_msg:conn closed|enable_multipath:0|send_state:0|recv_state:0|stream_id:11|stream_type:3|send_bytes:0|read_bytes:0|recv_bytes:0|stream_len:0|create_time:1731561210060401|wrt_delay:0|snd_delay:0|finwrt_delay:0|finsnd_delay:0|finrcv_delay:0|finread_delay:0|all_acked_delay:0|firstfinack_dely:0|close_delay:0|apprst_delay:0|rstsnd_delay:0|rstrcv_delay:0|l-10.37.30.62-8000-b827812dc384226bd72ee328 p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7|path_info:mp is not supported in connection scid:b827812dc384226bd72ee328||
2024/11/14 13:13:33.061|0000430514376[stats] |xqc_conn_server_init_path_addr|path:0|l-10.37.30.62-8000-56044760ab12fd02c891948a p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7||
2024/11/14 13:13:33.061|0000430514376[connection_started] |scid:56044760ab12fd02c891948a|xqc_conn_server_create|remote|dst_ip:10.37.30.62|dst_port:32455|scid:56044760ab12fd02c891948a|dcid:770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7||
2024/11/14 13:13:47.068|0000430528383[report] |scid:56044760ab12fd02c891948a|xqc_conn_destroy|00005581BF9DC800|has_0rtt:0|0rtt_accept:0|token_ok:0|handshake_time:0|first_send_delay:0|conn_persist:14007580|keyupdate_cnt:0|err:0x0|close_msg:idle timeout|l-10.37.30.62-8000-56044760ab12fd02c891948a p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7|hsk_recv:0|close_recv:0|close_send:0|last_recv:0|last_send:0|mp_enable:0|create:1|validated:1|active:1|path_info:1,0,0,0,0,0,0-2,0-0,0-0,0-250000,0-0,0-2400,0-0,0-2,0-0,0-0,0-0,0-0,0-0,0-0|alpn:|
2024/11/14 13:13:47.068|0000430528383[connection_closed] |scid:56044760ab12fd02c891948a|xqc_conn_destroy|err_code:0||
2024/11/14 13:13:47.068|0000430528383[report] |scid:56044760ab12fd02c891948a|xqc_conn_destroy|conn close notified by refuse|l-10.37.30.62-8000-56044760ab12fd02c891948a p-10.37.30.62-32455-770e6f4832fc2041a3e3e1f1569f6c1bcda0caa7|
2024/11/14 13:30:26.003|0000431527318[stats] |xqc_conn_server_init_path_addr|path:0|l-10.37.30.62-8000-41cb9a56c7dbc571734ba08f p-10.76.109.163-62304-4895d5||
2024/11/14 13:30:26.003|0000431527318[connection_started] |scid:41cb9a56c7dbc571734ba08f|xqc_conn_server_create|remote|dst_ip:10.76.109.163|dst_port:62304|scid:41cb9a56c7dbc571734ba08f|dcid:4895d5||
2024/11/14 13:30:28.359|0000431529674[report] |scid:41cb9a56c7dbc571734ba08f|xqc_conn_destroy|00005581BFADDB10|has_0rtt:0|0rtt_accept:0|token_ok:0|handshake_time:0|first_send_delay:0|conn_persist:2326438|keyupdate_cnt:0|err:0x150|close_msg:local error|l-10.37.30.62-8000-41cb9a56c7dbc571734ba08f p-10.76.109.163-62304-4895d5|hsk_recv:0|close_recv:0|close_send:426|last_recv:0|last_send:426|mp_enable:0|create:1|validated:1|active:1|path_info:1,0,0,0,0,0,0-2,0-0,0-0,0-250000,0-33,0-0,0-0,0-0,0-0,0-0,0-0,0-0,0-0,0-0|alpn:h3|
2024/11/14 13:30:28.359|0000431529674[connection_closed] |scid:41cb9a56c7dbc571734ba08f|xqc_conn_destroy|err_code:336||
2024/11/14 13:30:28.359|0000431529674[stats] |scid:41cb9a56c7dbc571734ba08f|xqc_destroy_stream|err:0x0|close_msg:conn closed|enable_multipath:0|send_state:0|recv_state:0|stream_id:3|stream_type:3|send_bytes:0|read_bytes:0|recv_bytes:0|stream_len:0|create_time:1731562226033494|wrt_delay:0|snd_delay:0|finwrt_delay:0|finsnd_delay:0|finrcv_delay:0|finread_delay:0|all_acked_delay:0|firstfinack_dely:0|close_delay:0|apprst_delay:0|rstsnd_delay:0|rstrcv_delay:0|l-10.37.30.62-8000-41cb9a56c7dbc571734ba08f p-10.76.109.163-62304-4895d5|path_info:mp is not supported in connection scid:41cb9a56c7dbc571734ba08f||
2024/11/14 13:30:28.359|0000431529674[stats] |scid:41cb9a56c7dbc571734ba08f|xqc_destroy_stream|err:0x0|close_msg:conn closed|enable_multipath:0|send_state:0|recv_state:0|stream_id:7|stream_type:3|send_bytes:0|read_bytes:0|recv_bytes:0|stream_len:0|create_time:1731562226033511|wrt_delay:0|snd_delay:0|finwrt_delay:0|finsnd_delay:0|finrcv_delay:0|finread_delay:0|all_acked_delay:0|firstfinack_dely:0|close_delay:0|apprst_delay:0|rstsnd_delay:0|rstrcv_delay:0|l-10.37.30.62-8000-41cb9a56c7dbc571734ba08f p-10.76.109.163-62304-4895d5|path_info:mp is not supported in connection scid:41cb9a56c7dbc571734ba08f||
2024/11/14 13:30:28.359|0000431529674[stats] |scid:41cb9a56c7dbc571734ba08f|xqc_destroy_stream|err:0x0|close_msg:conn closed|enable_multipath:0|send_state:0|recv_state:0|stream_id:11|stream_type:3|send_bytes:0|read_bytes:0|recv_bytes:0|stream_len:0|create_time:1731562226033525|wrt_delay:0|snd_delay:0|finwrt_delay:0|finsnd_delay:0|finrcv_delay:0|finread_delay:0|all_acked_delay:0|firstfinack_dely:0|close_delay:0|apprst_delay:0|rstsnd_delay:0|rstrcv_delay:0|l-10.37.30.62-8000-41cb9a56c7dbc571734ba08f p-10.76.109.163-62304-4895d5|path_info:mp is not supported in connection scid:41cb9a56c7dbc571734ba08f||

以下是error.log的日志

2024/11/14 13:48:17 [debug] 2525621#0: |xquic|packet_get_cid|dcid=298aba72c25b49d06bdec00fddf30bb4a1258c5d|targetWorkerId=0|ngx_worker=0|
2024/11/14 13:48:17 [debug] 2525621#0: |xquic|xqc_server_read_handler recv_size=1200d, recv_time=1731563297586489lu|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|type:CONN_IDLE|expire:1731563307586578|now:1731563297586578|interv:10000000||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|set|type:CONN_IDLE|expire:1731563307586578|interv:10000000||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|type:PATH_IDLE|expire:1731563307587018|now:1731563297587018|interv:10000000||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|set|type:PATH_IDLE|expire:1731563307587018|interv:10000000||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[rec_parameters_set] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_ctl_create|reordering_packet_threshold:3|reordering_time_threshold_shift:3||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |xqc_path_create|path:0|dcid:3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|scid:06e3cc74c816020ea3bd8e1a|create_path_count:1||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |xqc_path_init|path:0|dcid:3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|scid:06e3cc74c816020ea3bd8e1a|state:2||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_create|success|scid:06e3cc74c816020ea3bd8e1a|dcid:3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|conn:00005581BFA46C80||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[tra_parameters_set] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_create|local|migration:1|max_idle_timeout:120000|max_udp_payload_size:1500|active_connection_id_limit:8|max_data:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_server_create|hash odcid conn|odcid:298aba72c25b49d06bdec00fddf30bb4a1258c5d|conn:00005581BFA46C80||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_get_local_transport_params|generate sr_token[731856276217788270610e437138ef95] for cid[298aba72c25b49d06bdec00fddf30bb4a1258c5d]|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |xqc_conn_server_create|server accept new conn||
2024/11/14 13:48:17 [debug] 2525621#0: |xquic|ngx_xquic_server_conn_accept|dcid=06e3cc74c816020ea3bd8e1a|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[datagrams_received] |scid:06e3cc74c816020ea3bd8e1a|xqc_engine_packet_process|size:1200||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |xqc_engine_packet_process|==>|conn:00005581BFA46C80|size:1200|state:S_INIT|recv_time:1731563297586489||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_packet_parse_initial|packet parse|initial||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_packet_parse_initial|success|Length:1148||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_packet_decrypt_single|pkt_type:INIT|pkt_num:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_process_frames|frame_type:6||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_check_token|token empty||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_process_crypto_frame|check_token fail|conn:00005581BFA46C80|l-10.37.30.62-8000-06e3cc74c816020ea3bd8e1a p-10.37.30.62-40732-3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[frames_processed] |scid:06e3cc74c816020ea3bd8e1a|xqc_parse_crypto_frame|type:5|offset:0|length:512||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_create_crypto_stream|encrypt_level:0|cur_state:S_INIT||
2024/11/14 13:48:17 [debug] 2525621#0: |xquic|ngx_http_v3_conn_create_notify|00005581BF8D3090|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[http_stream_type_set] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_create|local|stream_id:3|stream_type:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|blocked by no 0RTT support||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|ret:-610|stream_id:3|stream_send_offset:0|pkt_type:SHORT_HEADER|buff_1rtt:0|send_data_size:1|offset:0|fin:0|stream_flag:17|conn:00005581BFA46C80|conn_state:S_INIT|flag:TICKING UPPER_CONN_EXIST INIT_RECVD ||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_conn_create_uni_stream|success|stream_id:3|stream_type:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[http_stream_type_set] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_create|local|stream_id:7|stream_type:2||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|blocked by no 0RTT support||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|ret:-610|stream_id:7|stream_send_offset:0|pkt_type:SHORT_HEADER|buff_1rtt:0|send_data_size:1|offset:0|fin:0|stream_flag:17|conn:00005581BFA46C80|conn_state:S_INIT|flag:TICKING UPPER_CONN_EXIST INIT_RECVD ||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_conn_create_uni_stream|success|stream_id:7|stream_type:2||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[http_stream_type_set] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_create|local|stream_id:11|stream_type:3||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|blocked by no 0RTT support||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|ret:-610|stream_id:11|stream_send_offset:0|pkt_type:SHORT_HEADER|buff_1rtt:0|send_data_size:1|offset:0|fin:0|stream_flag:17|conn:00005581BFA46C80|conn_state:S_INIT|flag:TICKING UPPER_CONN_EXIST INIT_RECVD ||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_conn_create_uni_stream|success|stream_id:11|stream_type:3||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[http_frame_created] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_write_setting_to_buffer|stream_id:3|type:4|max_field_section_size:32768|max_pushes:0||qpack_max_table_capacity:16384|qpack_blocked_streams:64||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|blocked by no 0RTT support||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_stream_send|ret:-610|stream_id:3|stream_send_offset:0|pkt_type:SHORT_HEADER|buff_1rtt:0|send_data_size:1|offset:0|fin:0|stream_flag:17|conn:00005581BFA46C80|conn_state:S_INIT|flag:TICKING UPPER_CONN_EXIST INIT_RECVD ||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_conn_send_settings|write settings success|qpack_blocked_streams:64|qpack_max_table_capacity:16384|max_field_section_size:32768|max_pushes:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_conn_create_notify|create h3 conn success||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_ssl_alpn_select_cb|select alpn|h3||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_ssl_cert_cbhostname is NULL|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_tls_send_alert|ssl alert|level:0|alert:80|error:error:1417A179:SSL routines:tls_post_process_client_hello:cert cb error|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_tls_error_cb|tls error|0x50||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_tls_error_cb|conn:00005581BFA46C80|err:0x150|l-10.37.30.62-8000-06e3cc74c816020ea3bd8e1a p-10.37.30.62-40732-3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_tls_do_handshake|TLS handshake error:error:00000000:lib(0):func(0):reason(0)||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_tls_process_crypto_data|xqc_do_handshake failed ||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_read_crypto_stream|xqc_tls_process_crypto_data error: -742||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_process_frames|process frame error|-636||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_packet_decrypt_single|xqc_process_frames error|-636||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_process_packet|process packets err|ret:-636|pos:00007FFC8BD341F4|buf:00005581BD24EF48|buf_size:1200||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |xqc_engine_packet_process|fail to process packets|conn:00005581BFA46C80|ret:-636||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_engine_process_conn|conn:00005581BFA46C80|state:S_INIT|flag:TICKING ERROR UPPER_CONN_EXIST INIT_RECVD CLOSING_NOTIFY |now:1731563297587628||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|type:CONN_DRAINING|expire:1731563299912632|now:1731563297587632|interv:2325000||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|set|type:CONN_DRAINING|expire:1731563299912632|interv:2325000||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_queue_drop_packets|sndq_packets_used:0|sndq_packets_used_bytes:0|sndq_packets_free:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_queue_drop_packets|path:0|ctl_bytes_in_flight:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|type:ACK_INIT||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|cancel|type:ACK_INIT||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|type:ACK_HSK||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|cancel|type:ACK_HSK||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|type:ACK_01RTT||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|cancel|type:ACK_01RTT||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|type:LOSS_DETECTION||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|cancel|type:LOSS_DETECTION||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_immediate_close|state to closing|state:S_INIT|flags:TICKING ERROR UPPER_CONN_EXIST INIT_RECVD CLOSING_NOTIFY |
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_immediate_close|gen_conn_close|state:CLOSING||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_check_acked_or_dropped_pkt|conn:00005581BFA46C80|pkt_num:0|size:50|pkt_type:INIT|frame:CONNECTION_CLOSE ||
2024/11/14 13:48:17 [debug] 2525621#0: |xquic|ngx_xquic_server_send_mmsg|vlen=1 now=1731563297587697|dcid=06e3cc74c816020ea3bd8e1a|
2024/11/14 13:48:17 [debug] 2525621#0: |xquic|ngx_xquic_server_send_mmsg success|total_len=1 now=1731563297587728|dcid=06e3cc74c816020ea3bd8e1a|send_len=1|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_ctl_on_packet_sent|conn:00005581BFA46C80|path:0|pkt_num:0|origin_pktnum:0|size:50|pkt_type:INIT|frame:CONNECTION_CLOSE |conn_state:CLOSING|po_in_flight:0||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_on_packets_send_burst|<==|conn:00005581BFA46C80|path:0|pkt_num:0|size:50|sent:1|pkt_type:INIT|frame:CONNECTION_CLOSE |inflight:0|now:1731563297587684||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_next_wakeup_time|wakeup_time:1731563299912632||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
2024/11/14 13:48:17 [debug] 2525621#0: |xquic|xqc_server_read_handler: packet process err|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
2024/11/14 13:48:18 [debug] 2525621#0: |xquic|packet_get_cid|dcid=06e3cc74c816020ea3bd8e1a|targetWorkerId=0|ngx_worker=0|
2024/11/14 13:48:18 [debug] 2525621#0: |xquic|xqc_server_read_handler recv_size=1200d, recv_time=1731563298588021lu|
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[datagrams_received] |scid:06e3cc74c816020ea3bd8e1a|xqc_engine_packet_process|size:1200||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[info] |xqc_engine_packet_process|==>|conn:00005581BFA46C80|size:1200|state:CLOSING|recv_time:1731563298588021||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_packet_parse_initial|packet parse|initial||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_packet_parse_initial|success|Length:1156||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_packet_decrypt_single|pkt_type:INIT|pkt_num:1||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_process_frames|closing state|frame_type:6||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_immediate_close|gen_conn_close|state:CLOSING||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_addr_validated|Address Validated|conn:00005581BFA46C80|role:1||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_ctl_set_loss_detection_timer|unset|no ack-eliciting pkts in flight|conn:00005581BFA46C80|path:0||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|type:LOSS_DETECTION||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|cancel|type:LOSS_DETECTION||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_record_single|path:0|xqc_recv_record_add|status:0|pkt_num:1|largest:1|pns:0||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_on_pkt_processed|====>|conn:00005581BFA46C80|path:0|size:1200|pkt_type:INIT|pkt_num:1|frame:|recv_time:1731563298588021||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[packet_received] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_process_packet|pkt_pns:0|pkt_type:0|pkt_num:1|len:1200|frame_flag:||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|type:PATH_IDLE|expire:1731563308588021|now:1731563298588021|interv:10000000||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|set|type:PATH_IDLE|expire:1731563308588021|interv:10000000||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|type:CONN_IDLE|expire:1731563308588021|now:1731563298588021|interv:10000000||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_set|set|type:CONN_IDLE|expire:1731563308588021|interv:10000000||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_engine_process_conn|conn:00005581BFA46C80|state:CLOSING|flag:WAIT_WAKEUP TICKING ERROR DCID_OK UPPER_CONN_EXIST INIT_RECVD ADDR_VALIDATED CLOSING_NOTIFY |now:1731563298588147||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_immediate_close|gen_conn_close|state:CLOSING||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_check_acked_or_dropped_pkt|conn:00005581BFA46C80|pkt_num:0|size:50|pkt_type:INIT|frame:CONNECTION_CLOSE ||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_check_acked_or_dropped_pkt|conn:00005581BFA46C80|pkt_num:0|size:50|pkt_type:INIT|frame:CONNECTION_CLOSE ||
2024/11/14 13:48:18 [debug] 2525621#0: |xquic|ngx_xquic_server_send_mmsg|vlen=2 now=1731563298588172|dcid=06e3cc74c816020ea3bd8e1a|
2024/11/14 13:48:18 [debug] 2525621#0: |xquic|ngx_xquic_server_send_mmsg success|total_len=2 now=1731563298588204|dcid=06e3cc74c816020ea3bd8e1a|send_len=2|
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_ctl_on_packet_sent|conn:00005581BFA46C80|path:0|pkt_num:1|origin_pktnum:0|size:50|pkt_type:INIT|frame:CONNECTION_CLOSE |conn_state:CLOSING|po_in_flight:0||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_on_packets_send_burst|<==|conn:00005581BFA46C80|path:0|pkt_num:1|size:50|sent:2|pkt_type:INIT|frame:CONNECTION_CLOSE |inflight:0|now:1731563298588161||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_ctl_on_packet_sent|conn:00005581BFA46C80|path:0|pkt_num:2|origin_pktnum:0|size:50|pkt_type:INIT|frame:CONNECTION_CLOSE |conn_state:CLOSING|po_in_flight:0||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[info] |scid:06e3cc74c816020ea3bd8e1a|xqc_on_packets_send_burst|<==|conn:00005581BFA46C80|path:0|pkt_num:2|size:50|sent:2|pkt_type:INIT|frame:CONNECTION_CLOSE |inflight:0|now:1731563298588161||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_conn_next_wakeup_time|wakeup_time:1731563299912632||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:18 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_engine_process_conn|conn:00005581BFA46C80|state:CLOSING|flag:TICKING ERROR DCID_OK UPPER_CONN_EXIST INIT_RECVD ADDR_VALIDATED CLOSING_NOTIFY |now:1731563299913631||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_expire|timer expired|type:CONN_DRAINING|expire_time:1731563299912632|now:1731563299913631||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_expire|expired|type:CONN_DRAINING|expire_time:1731563299912632||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_expire|unset|type:CONN_DRAINING|expire_time:1731563299912632|now:1731563299913631||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|type:CONN_DRAINING||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:06e3cc74c816020ea3bd8e1a|xqc_timer_unset|cancel|type:CONN_DRAINING||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[info] |xqc_engine_main_logic|destroy conn from conns_active_pq while closed|conn:00005581BFA46C80|l-10.37.30.62-8000-06e3cc74c816020ea3bd8e1a p-10.37.30.62-40732-3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_destroy_stream|send_state:0|recv_state:0|stream_id:3|stream_type:3||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_close_notify|destroy h3 stream success|h3_stream_type:0|stream_id:3|blocked:0|
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_destroy|stream_id:3|h3_stream_type:0||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_destroy_stream|send_state:0|recv_state:0|stream_id:7|stream_type:3||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_close_notify|destroy h3 stream success|h3_stream_type:2|stream_id:7|blocked:0|
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_destroy|stream_id:7|h3_stream_type:2||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_destroy_stream|send_state:0|recv_state:0|stream_id:11|stream_type:3||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_close_notify|destroy h3 stream success|h3_stream_type:3|stream_id:11|blocked:0|
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_stream_destroy|stream_id:11|h3_stream_type:3||
2024/11/14 13:48:19 [debug] 2525621#0: |xquic|ngx_http_v3_conn_close_notify|err=336|
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|ngx_http_v3_conn_close|err=336|
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_conn_destroy|success||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_h3_conn_close_notify|destroy h3 conn success||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_send_ctl_destroy|destroy||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |scid:06e3cc74c816020ea3bd8e1a|xqc_destroy_crypto_stream|destroy crypto stream|encrypt_level:0|cur_state:CLOSED||
2024/11/14 13:48:19 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
2024/11/14 13:48:20 [debug] 2525621#0: |xquic|packet_get_cid|dcid=06e3cc74c816020ea3bd8e1a|targetWorkerId=0|ngx_worker=0|
2024/11/14 13:48:20 [debug] 2525621#0: |xquic|xqc_server_read_handler recv_size=1200d, recv_time=1731563300588516lu|
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|type:CONN_IDLE|expire:1731563310588548|now:1731563300588548|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|set|type:CONN_IDLE|expire:1731563310588548|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|type:PATH_IDLE|expire:1731563310588597|now:1731563300588597|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|set|type:PATH_IDLE|expire:1731563310588597|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[rec_parameters_set] |scid:c45bd25cdda2a644a7773d9e|xqc_send_ctl_create|reordering_packet_threshold:3|reordering_time_threshold_shift:3||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |xqc_path_create|path:0|dcid:3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|scid:c45bd25cdda2a644a7773d9e|create_path_count:1||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |xqc_path_init|path:0|dcid:3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|scid:c45bd25cdda2a644a7773d9e|state:2||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_create|success|scid:c45bd25cdda2a644a7773d9e|dcid:3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|conn:00005581BFEE8070||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[tra_parameters_set] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_create|local|migration:1|max_idle_timeout:120000|max_udp_payload_size:1500|active_connection_id_limit:8|max_data:0||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[info] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_server_create|hash odcid conn|odcid:06e3cc74c816020ea3bd8e1a|conn:00005581BFEE8070||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[info] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_get_local_transport_params|generate sr_token[ca8acbb2734d50c2ae66b8a619e81f76] for cid[06e3cc74c816020ea3bd8e1a]|
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |xqc_conn_server_create|server accept new conn||
2024/11/14 13:48:20 [debug] 2525621#0: |xquic|ngx_xquic_server_conn_accept|dcid=c45bd25cdda2a644a7773d9e|
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[datagrams_received] |scid:c45bd25cdda2a644a7773d9e|xqc_engine_packet_process|size:1200||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[info] |xqc_engine_packet_process|==>|conn:00005581BFEE8070|size:1200|state:S_INIT|recv_time:1731563300588516||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_parse_initial|packet parse|initial||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_parse_initial|success|Length:1156||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[info] |scid:c45bd25cdda2a644a7773d9e|xqc_crypto_decrypt_payload|decrypt payload error|ret:-737|write:0||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[warn] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_decrypt|xqc_tls_decrypt_payload error||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[warn] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_decrypt_single|decrypt data error, return|-737|pkt_type:INIT|pkt_num:182||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[info] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_process_packet|ignore err|-622||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|type:PATH_IDLE|expire:1731563310588516|now:1731563300588516|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|set|type:PATH_IDLE|expire:1731563310588516|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|type:CONN_IDLE|expire:1731563310588516|now:1731563300588516|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|set|type:CONN_IDLE|expire:1731563310588516|interv:10000000||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_engine_process_conn|conn:00005581BFEE8070|state:S_INIT|flag:TICKING UPPER_CONN_EXIST INIT_RECVD |now:1731563300588780||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_next_wakeup_time|wakeup_time:1731563310588516||
2024/11/14 13:48:20 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
2024/11/14 13:48:24 [debug] 2525621#0: |xquic|packet_get_cid|dcid=06e3cc74c816020ea3bd8e1a|targetWorkerId=0|ngx_worker=0|
2024/11/14 13:48:24 [debug] 2525621#0: |xquic|xqc_server_read_handler recv_size=1200d, recv_time=1731563304586851lu|
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[datagrams_received] |scid:c45bd25cdda2a644a7773d9e|xqc_engine_packet_process|size:1200||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[info] |xqc_engine_packet_process|==>|conn:00005581BFEE8070|size:1200|state:S_INIT|recv_time:1731563304586851||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_parse_initial|packet parse|initial||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_parse_initial|success|Length:1156||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[info] |scid:c45bd25cdda2a644a7773d9e|xqc_crypto_decrypt_payload|decrypt payload error|ret:-737|write:0||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[warn] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_decrypt|xqc_tls_decrypt_payload error||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[warn] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_decrypt_single|decrypt data error, return|-737|pkt_type:INIT|pkt_num:122||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[info] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_process_packet|ignore err|-622||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|type:PATH_IDLE|expire:1731563314586851|now:1731563304586851|interv:10000000||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|set|type:PATH_IDLE|expire:1731563314586851|interv:10000000||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|type:CONN_IDLE|expire:1731563314586851|now:1731563304586851|interv:10000000||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_set|set|type:CONN_IDLE|expire:1731563314586851|interv:10000000||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_engine_process_conn|conn:00005581BFEE8070|state:S_INIT|flag:WAIT_WAKEUP TICKING UPPER_CONN_EXIST INIT_RECVD |now:1731563304586908||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_conn_next_wakeup_time|wakeup_time:1731563314586851||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|BEGIN||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_engine_process_conn|conn:00005581BFEE8070|state:S_INIT|flag:TICKING UPPER_CONN_EXIST INIT_RECVD |now:1731563314596007||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_expire|conn:00005581BFEE8070|timer expired|type:CONN_IDLE|expire_time:1731563314586851|now:1731563314596007||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_expire|expired|type:CONN_IDLE|expire_time:1731563314586851||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_expire|unset|type:CONN_IDLE|expire_time:1731563314586851|now:1731563314596007||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_unset|type:CONN_IDLE||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_unset|cancel|type:CONN_IDLE||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_expire|timer expired|type:PATH_IDLE|expire_time:1731563314586851|now:1731563314596007||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_expire|expired|type:PATH_IDLE|expire_time:1731563314586851||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_expire|unset|type:PATH_IDLE|expire_time:1731563314586851|now:1731563314596007||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_unset|type:PATH_IDLE||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[loss_timer_updated] |scid:c45bd25cdda2a644a7773d9e|xqc_timer_unset|cancel|type:PATH_IDLE||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[info] |xqc_engine_main_logic|destroy conn from conns_active_pq while closed|conn:00005581BFEE8070|l-10.37.30.62-8000-c45bd25cdda2a644a7773d9e p-10.37.30.62-40732-3adfc22d5a230abaa9ebc6a62bcff6319faf9b2c|
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|ngx_xquic_server_conn_refuse|scid=c45bd25cdda2a644a7773d9e|
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |scid:c45bd25cdda2a644a7773d9e|xqc_send_ctl_destroy|destroy||
2024/11/14 13:48:34 [warn] 2525621#0: |xquic|lib[debug] |xqc_engine_main_logic|END||
D-NanSheng commented 15 hours ago

./curl -v -k --http3-only https://10.37.30.62:8000

这个是客户端的命令。在握手阶段就报错了

drawing commented 8 hours ago

@D-NanSheng 

2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_ssl_cert_cbhostname is NULL|
2024/11/14 13:48:17 [warn] 2525621#0: |xquic|lib[error] |scid:06e3cc74c816020ea3bd8e1a|xqc_tls_send_alert|ssl alert|level:0|alert:80|error:error:1417A179:SSL routines:tls_post_process_client_hello:cert cb error|

最开始有个错误提示 hostname 为空，没有携带 sni，H3 协议要求携带sni，应该是 curl 使用 ip 访问没携带 sni，可以尝试 curl 使用构造的域名访问，例如：

curl -v -k --http3-only https://abc.com:8000 --resolve "abc.com:8000:10.37.30.62"

后面还有一个错误提示解密失败：

2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[info] |scid:c45bd25cdda2a644a7773d9e|xqc_crypto_decrypt_payload|decrypt payload error|ret:-737|write:0||
2024/11/14 13:48:24 [warn] 2525621#0: |xquic|lib[warn] |scid:c45bd25cdda2a644a7773d9e|xqc_packet_decrypt|xqc_tls_decrypt_payload error||

现有信息无法判断错误原因是什么，先尝试解决前一个问题看看能否通过，xquic 本身是可以使用 openssl 生成的自签证书的。