Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

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

Open
D-NanSheng opened this issue Nov 14, 2024 · 4 comments
Open

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

D-NanSheng opened this issue Nov 14, 2024 · 4 comments
Assignees
@chobits

Comments

@D-NanSheng
Copy link

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
Copy link
Author

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

  • Trying 10.37.30.62:8000...
  • ngtcp2_conn_handle_expiry returned error: ERR_HANDSHAKE_TIMEOUT
  • Failed to connect to 10.37.30.62 port 8000 after 10002 ms: Failed sending data to the peer
  • closing connection #0
    curl: (55) ngtcp2_conn_handle_expiry returned error: ERR_HANDSHAKE_TIMEOUT

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

@drawing
Copy link
Collaborator

drawing commented Nov 14, 2024 •
edited
Loading

@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 生成的自签证书的。

@D-NanSheng
Copy link
Author

D-NanSheng commented Nov 15, 2024 •
edited
Loading

感谢，按照上述操作并在本地hosts添加域名转换后curl已经成功了，但是curl不带-k的话也无法通信。同时我又出现了下面的问题。

直播传输场景：client通过rtmp推流到server，再用(https://bilibili.github.io/flv.js/demo/) 通过http-flv从server拉流

已知条件：火狐浏览器点播mp4可以切换成QUIC，谷歌chrome仍然不行。 但是两个浏览器无法在直播传输场景切换成QUIC。

日志报错信息如下：

2024/11/15 13:36:56 [info] 3234662#0: *2 SSL_do_handshake() failed (SSL: error:14094416:SSL routines:ssl3_read_bytes:sslv3 alert certificate unknown:SSL alert number 46) while SSL handshaking, client: 10.76.109.163, server: 0.0.0.0:8000
2024/11/15 13:36:56 [error] 3234662#0: *5 flv live: HTTP method was not "GET", client: 10.37.30.62, server: , request: "OPTIONS /live?port=1935&app=myapp&stream=stream-123456 HTTP/1.0", host: "10.37.30.62", referrer: "https://bilibili.github.io/flv.js/demo/"

nginx的配置如下：


worker_processes  1;
user root;
error_log  logs/error.log debug;
events {
    worker_connections  1024;
}
xquic_log   "pipe:rollback /home/guopeisheng/workbench/QuicBBR/tengine-xquic.log baknum=10 maxsize=1G interval=1d adjust=600" debug;
# xuqic http 配置
http {
    include       mime.types;
    default_type  application/octet-stream;
    #keepalive_timeout  65;

    xquic_ssl_certificate        /home/guopeisheng/workbench/QuicBBR/cert/localhost.crt;
    xquic_ssl_certificate_key    /home/guopeisheng/workbench/QuicBBR/cert/localhost.key;
    # xquic_early_data on;
    xquic_congestion_control bbr;
    xquic_socket_rcvbuf 5242880;
    xquic_socket_sndbuf 5242880;
    xquic_anti_amplification_limit 5;
    xquic_log_level debug;
    server {
        listen 8000 ssl http2;
        listen 8000 xquic reuseport;
        server_name guopeisheng;
        
        add_header Alt-Svc 'h3=":8000"; ma=2592000,h3-29=":8000"; ma=2592000;' always;
        
        #ssl_protocols       TLSv1 TLSv1.1 TLSv1.2 TLSv1.3;
        ssl_protocols       TLSv1.3;
        ssl_certificate        /home/guopeisheng/workbench/QuicBBR/cert/localhost.crt;
        ssl_certificate_key    /home/guopeisheng/workbench/QuicBBR/cert/localhost.key;
        # 根文件
        location / {
            root   html;
            index  index.html index.htm;

            autoindex on;
            autoindex_exact_size   on;
        }
        # mp4视频
        location /video/ {
            alias /usr/local/tengine/video/;
            mp4;
            mp4_buffer_size       1m;
            mp4_max_buffer_size   5m;
            mp4_start_key_frame on;
            # mp4_limit_rate        on; # 商业版才有
            # mp4_limit_rate_after  30s; # 商业版才有
        }
        # http-flv直播 https://我的域名:8000/live?port=1935&app=myapp&stream=stream-123456
        location /live {
            proxy_pass http://10.37.30.62:80/live;  # 将请求代理到目标服务器的指定路径，注意要与目标服务器提供服务的路径一致，这里去掉了后面的查询参数，因为查询参数会在代理过程中自动传递
            # proxy_set_timeout 300;  # 设置代理请求的超时时间，可根据实际情况调整
            # flv_live on; #打开 HTTP 播放 FLV 直播流功能
            # chunked_transfer_encoding on; #支持 'Transfer-Encoding: chunked' 方式回复

            # add_header 'Access-Control-Allow-Origin' '*'; #添加额外的 HTTP 头
            # add_header 'Access-Control-Allow-Credentials' 'true'; #添加额外的 HTTP 头
            # #add_header Access-Control-Allow-Headers X-Requested-With;
            # add_header Access-Control-Allow-Methods 'GET,POST,OPTIONS';
            # add_header 'Cache-Control' 'no-cache';
        }
        # location /hls {
        #     types {
        #         application/vnd.apple.mpegurl m3u8;
        #         video/mp2t ts;
        #     }

        #     root /tmp;
        #     add_header 'Cache-Control' 'no-cache';
        # }

        # location /dash {
        #     root /tmp;
        #     add_header 'Cache-Control' 'no-cache';
        # }

        # location /stat {
        #     #推流播放和录制统计数据的配置

        #     rtmp_stat all;
        #     rtmp_stat_stylesheet stat.xsl;
        # }

        # location /stat.xsl {
        #     root /var/www/rtmp; #指定 stat.xsl 的位置
        # }

        # #如果需要 JSON 风格的 stat, 不用指定 stat.xsl
        # #但是需要指定一个新的配置项 rtmp_stat_format

        # #location /stat {
        # #    rtmp_stat all;
        # #    rtmp_stat_format json;
        # #}

        # location /control {
        #     rtmp_control all; #rtmp 控制模块的配置
        # }

    }

    server {
        listen       10.37.30.62:80 default;
        #listen 10.37.30.62:8080 ssl;

        # ssl_protocols       TLSv1.3;
        # ssl_certificate        /home/guopeisheng/workbench/QuicBBR/cert/cacert.pem;
        # ssl_certificate_key    /home/guopeisheng/workbench/QuicBBR/cert/privkey.pem;

        location / {
            root   html;
            index  index.html index.htm;
        }

        error_page   500 502 503 504  /50x.html;
        location = /50x.html {
            root   html;
        }

        location /live {
            flv_live on; #打开 HTTP 播放 FLV 直播流功能
            chunked_transfer_encoding on; #支持 'Transfer-Encoding: chunked' 方式回复

            add_header 'Access-Control-Allow-Origin' '*'; #添加额外的 HTTP 头
            add_header 'Access-Control-Allow-Credentials' 'true'; #添加额外的 HTTP 头
        }

        location /hls {
            types {
                application/vnd.apple.mpegurl m3u8;
                video/mp2t ts;
            }

            root /tmp;
            add_header 'Cache-Control' 'no-cache';
        }

        location /dash {
            root /tmp;
            add_header 'Cache-Control' 'no-cache';
        }

        location /stat {
            #推流播放和录制统计数据的配置

            rtmp_stat all;
            rtmp_stat_stylesheet stat.xsl;
        }

        location /stat.xsl {
            root /var/www/rtmp; #指定 stat.xsl 的位置
        }

        #如果需要 JSON 风格的 stat, 不用指定 stat.xsl
        #但是需要指定一个新的配置项 rtmp_stat_format

        #location /stat {
        #    rtmp_stat all;
        #    rtmp_stat_format json;
        #}

        location /control {
            rtmp_control all; #rtmp 控制模块的配置
        }
    }

}

rtmp_auto_push on;
rtmp_auto_push_reconnect 1s;
rtmp_socket_dir /tmp;
# rtmp推流 
# ffmpeg -re -i MEDIA_FILE_NAME -c copy -f flv rtmp://example.com[:port]/appname/streamname
rtmp {
    out_queue           4096;
    out_cork            8;
    max_streams         128;
    timeout             15s;
    drop_idle_publisher 15s;

    log_interval 5s; #log 模块在 access.log 中记录日志的间隔时间，对调试非常有用
    log_size     1m; #log 模块用来记录日志的缓冲区大小
   
    server {
        listen 10.37.30.62:1935;  # RTMP服务监听端口
        chunk_size 4000;
         # RTMP播放--rtmp://example.com[:port]/appname/streamname
        application myapp {
            live on;
            gop_cache on; #打开 GOP 缓存，减少首屏等待时间
        }
        # HLS播放--http://example.com[:port]/dir/streamname.m3u8
        application hls {
            live on;
            hls on;
            hls_path /tmp/hls;
        }
        # DASH播放——http://example.com[:port]/dir/streamname.mpd
        application dash {
            live on;
            dash on;
            dash_path /tmp/dash;
        }
    }
}

@drawing
Copy link
Collaborator

drawing commented Nov 15, 2024 •
edited
Loading

@D-NanSheng curl 不加 -k 参数无法成功是符合预期的，因为证书是自签的，不加 -k 参数 curl 需要校验证书，无法通过。

自签证书 chrome h3 无法建联，这个问题之前也遇到过，自签的证书，即使加到 mac 受信证书列表，chrome h3 协议也会拦截，firefox 是可以联通的，应该是 chrome 对 H3 协议校验的更为严格，如果浏览器访问，最好不要使用自签证书吧

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@chobits chobits

Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@chobits @drawing @D-NanSheng