问题:
- 日志提示一直在抛出异常
- java客户端一直尝试重连emqx broker
- 其它客户端与emqx broker也是重复连接断开连接
环境: - 网络正常
- emqx 4.3.5
- 监测emqx 的内存使用不到30%,cpu使用不到1%
emqx日志如下:
2025-03-08T02:02:18.761171+08:00 [error] 59.82.21.131:8812 [MQTT] , Parse failed for function_clause, [{emqx_frame,parse_packet,[{mqtt_packet_header,4,false,3,true},<<"T / HTTP/1.1\r\nUser-Agent: Mozilla/5.0 (Windows NT 10"...>>,#{max_size => 1048576,strict_mode => false,version => 4}],[{file,"emqx_frame.erl"},{line,204}]},{emqx_frame,parse_frame,4,[{file,"emqx_frame.erl"},{line,181}]},{emqx_connection,parse_incoming,3,[{file,"emqx_connection.erl"},{line,625}]},{emqx_connection,handle_msg,2,[{file,"emqx_connection.erl"},{line,618}]},{emqx_connection,process_msg,2,[{file,"emqx_connection.erl"},{line,364}]},{emqx_connection,handle_recv,3,[{file,"emqx_connection.erl"},{line,328}]},{proc_lib,wake_up,3,[{file,"proc_lib.erl"},{line,236}]}], Frame data:<<"GET / HTTP/1.1\r\nUser-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleW"...>>
2025-03-08T02:02:18.771116+08:00 [error] 59.82.21.82:6788 [MQTT] , Parse failed for function_clause, [{emqx_frame,parse_packet,[{mqtt_packet_header,4,false,3,true},<<"T / HTTP/1.1\r\nUser-Agent: Mozilla/5.0 (Windows NT 10"...>>,#{max_size => 1048576,strict_mode => false,version => 4}],[{file,"emqx_frame.erl"},{line,204}]},{emqx_frame,parse_frame,4,[{file,"emqx_frame.erl"},{line,181}]},{emqx_connection,parse_incoming,3,[{file,"emqx_connection.erl"},{line,625}]},{emqx_connection,handle_msg,2,[{file,"emqx_connection.erl"},{line,618}]},{emqx_connection,process_msg,2,[{file,"emqx_connection.erl"},{line,364}]},{emqx_connection,handle_recv,3,[{file,"emqx_connection.erl"},{line,328}]},{proc_lib,wake_up,3,[{file,"proc_lib.erl"},{line,236}]}], Frame data:<<"GET / HTTP/1.1\r\nUser-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleW"...>>
2025-03-08T08:05:52.125369+08:00 [warning] test1@39.144.74.66:27153 [Channel] Cannot publish message to /ext/session/test1/aaa/bbb/combine/login due to Not authorized.
2025-03-08T08:24:01.909997+08:00 [warning] test2@39.144.74.72:11390 [Channel] Cannot publish message to /ext/session/test2/aaa/bbb/combine/login due to Not authorized.
2025-03-08T08:55:49.723784+08:00 [warning] test3@39.144.74.97:21398 [Channel] Cannot publish message to /ext/session/test3/aaa/bbb/combine/login due to Not authorized.
2025-03-08T11:56:47.781029+08:00 [warning] test@205.210.31.13:63234 [Channel] Client test (Username: 'undefined') login failed for not_authorized
2025-03-08T12:09:44.282971+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1677.0>, info: [{timeout,413}, {in,undefined}, {out,undefined}], [{initial_call,{proc_lib,init_p,5}},{current_function,{erlang,hibernate,3}},{registered_name,ekka_locker},{status,waiting},{message_queue_len,0},{group_leader,<0.1670.0>},{priority,normal},{trap_exit,false},{reductions,966659},{last_calls,false},{catchlevel,0},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,1416},{total_heap_size,53},{heap_size,...},{...}|...]
2025-03-08T12:09:44.723876+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.3926.0>, info: [{timeout,2881}, {in, {emqx_connection,recvloop,2}}, {out, {emqx_connection,recvloop, 2}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{emqx_connection,recvloop,2}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1552.0>},{priority,normal},{trap_exit,false},{reductions,3462422},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,14184},{total_heap_size,1612},{heap_size,...},{...}|...]
2025-03-08T12:09:46.902061+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1494.0>, info: [{timeout,785}, {in,{gen_server,loop,7}}, {out,{gen_server,loop,7}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,ssl_manager},{status,running},{message_queue_len,0},{group_leader,<0.1486.0>},{priority,normal},{trap_exit,true},{reductions,64248},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,5820},{total_heap_size,609},{heap_size,...},{...}|...]
2025-03-08T12:09:47.263815+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.29408.3>, info: [{timeout,619}, {in,undefined}, {out,{erlang,put,2}}], undefined
2025-03-08T12:09:47.263995+08:00 [warning] [SYSMON] long_schedule warning: port = #Port<0.59>, info: [{timeout,298}, {port_op,input}], [{name,"tcp_inet"},{links,[<0.2188.0>]},{id,472},{connected,<0.2188.0>},{input,0},{output,6058},{os_pid,undefined}]
2025-03-08T12:09:49.032460+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1719.0>, info: [{timeout,942}, {in,{gen_server,loop,7}}, {out,{lists,thing_to_list,1}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{erlang,atom_to_list,1}},{registered_name,emqx_sys},{status,running},{message_queue_len,0},{group_leader,<0.1569.0>},{priority,normal},{trap_exit,false},{reductions,262396871},{last_calls,false},{catchlevel,2},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,21548},{total_heap_size,2585},{heap_size,...},{...}|...]
2025-03-08T12:09:49.133214+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1774.0>, info: [{timeout,502}, {in, {mysql_conn,handle_call,3}}, {out,{prim_inet,recv0,3}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{prim_inet,recv0,3}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1767.0>},{priority,normal},{trap_exit,true},{reductions,21408621},{last_calls,false},{catchlevel,2},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,88628},{total_heap_size,10957},{heap_size,...},{...}|...]
2025-03-08T12:09:49.571519+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1567.0>, info: [{timeout,259}, {in, {erts_internal,await_result, 1}}, {out,{gen_server,loop,7}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,cowboy_clock},{status,waiting},{message_queue_len,0},{group_leader,<0.1564.0>},{priority,normal},{trap_exit,false},{reductions,4688315},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,11852},{total_heap_size,1363},{heap_size,...},{...}|...]
2025-03-08T12:09:52.611706+08:00 [warning] [SYSMON] long_schedule warning: port = #Port<0.9>, info: [{timeout,1258}, {port_op,proc_sig}], [{name,"\"/opt/emqx/lib/os_mon-2.6.1/priv/bin/memsup\""},{links,[<0.1515.0>]},{id,72},{connected,<0.1515.0>},{input,53892},{output,2994},{os_pid,267}]
2025-03-08T12:09:58.395149+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1675.0>, info: [{timeout,1529}, {in,{gen_server,loop,7}}, {out,{gen_server,loop,7}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,ekka_node_monitor},{status,waiting},{message_queue_len,0},{group_leader,<0.1670.0>},{priority,normal},{trap_exit,true},{reductions,3446782},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,16764},{total_heap_size,1974},{heap_size,...},{...}|...]
2025-03-08T12:09:58.664858+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1687.0>, info: [{timeout,537}, {in,{gen_server,loop,7}}, {out,undefined}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,emqx_stats},{status,waiting},{message_queue_len,0},{group_leader,<0.1569.0>},{priority,normal},{trap_exit,false},{reductions,33794995},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,5092},{total_heap_size,518},{heap_size,...},{...}|...]
2025-03-08T12:09:58.665189+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1555.0>, info: [{timeout,637}, {in,{gen_server,loop,7}}, {out,{gen_server,loop,7}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,esockd_limiter},{status,waiting},{message_queue_len,0},{group_leader,<0.1552.0>},{priority,normal},{trap_exit,false},{reductions,10870118},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,16740},{total_heap_size,1974},{heap_size,...},{...}|...]
2025-03-08T12:09:58.665463+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1587.0>, info: [{timeout,509}, {in,{gen_server,loop,7}}, {out,{gen_server,loop,7}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,mnesia_recover},{status,waiting},{message_queue_len,0},{group_leader,<0.1578.0>},{priority,normal},{trap_exit,true},{reductions,826929},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,8836},{total_heap_size,986},{heap_size,...},{...}|...]
2025-03-08T12:09:58.665656+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1806.0>, info: [{timeout,354}, {in,{gen_server,loop,7}}, {out,{gen_server,loop,7}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,emqx_rule_metrics},{status,waiting},{message_queue_len,0},{group_leader,<0.1802.0>},{priority,normal},{trap_exit,true},{reductions,1894258},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,42244},{total_heap_size,5172},{heap_size,...},{...}|...]
2025-03-08T12:09:58.685738+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1794.0>, info: [{timeout,330}, {in,{gen_server,loop,7}}, {out, {erts_internal,await_result, 1}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1767.0>},{priority,normal},{trap_exit,true},{reductions,12029535},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,55128},{total_heap_size,6777},{heap_size,...},{...}|...]
2025-03-08T12:10:05.022841+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.2188.0>, info: [{timeout,2114}, {in, {emqx_connection,recvloop,2}}, {out, {emqx_connection,recvloop, 2}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{emqx_connection,recvloop,2}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1552.0>},{priority,normal},{trap_exit,false},{reductions,3903491},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,17080},{total_heap_size,1974},{heap_size,...},{...}|...]
2025-03-08T12:10:05.023299+08:00 [warning] [SYSMON] long_schedule warning: port = #Port<0.7640>, info: [{timeout,2979}, {port_op,input}], [{name,"tcp_inet"},{links,[<0.30023.0>]},{id,61120},{connected,<0.30023.0>},{input,0},{output,4768},{os_pid,undefined}]
2025-03-08T12:10:05.023567+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.4236.0>, info: [{timeout,441}, {in,undefined}, {out, {emqx_connection,recvloop, 2}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{emqx_connection,recvloop,2}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1552.0>},{priority,normal},{trap_exit,false},{reductions,3391072},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,14064},{total_heap_size,1597},{heap_size,...},{...}|...]
2025-03-08T12:10:05.023811+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.6882.0>, info: [{timeout,480}, {in,undefined}, {out, {emqx_connection,recvloop, 2}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{emqx_connection,recvloop,2}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1552.0>},{priority,normal},{trap_exit,false},{reductions,3839758},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,14064},{total_heap_size,1597},{heap_size,...},{...}|...]
2025-03-08T12:10:08.952567+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.3913.0>, info: [{timeout,560}, {in, {emqx_connection,recvloop,2}}, {out,{gen,do_call,4}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen,do_call,4}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1552.0>},{priority,normal},{trap_exit,false},{reductions,3658341},{last_calls,false},{catchlevel,5},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,17140},{total_heap_size,1974},{heap_size,...},{...}|...]
2025-03-08T12:10:09.363025+08:00 [warning] [SYSMON] long_schedule warning: port = #Port<0.32>, info: [{timeout,529}, {port_op,input}], [{name,"tcp_inet"},{links,[<0.2045.0>]},{id,256},{connected,<0.2045.0>},{input,0},{output,10224},{os_pid,undefined}]
2025-03-08T12:10:09.363393+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1713.0>, info: [{timeout,511}, {in,undefined}, {out,undefined}], [{initial_call,{proc_lib,init_p,5}},{current_function,{erlang,hibernate,3}},{registered_name,emqx_cm_locker},{status,waiting},{message_queue_len,0},{group_leader,<0.1569.0>},{priority,normal},{trap_exit,false},{reductions,966688},{last_calls,false},{catchlevel,0},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,1416},{total_heap_size,53},{heap_size,...},{...}|...]
2025-03-08T12:10:09.363755+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.1779.0>, info: [{timeout,449}, {in,{gen_server,loop,7}}, {out,{gen_server,loop,7}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{gen_server,loop,7}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1767.0>},{priority,normal},{trap_exit,true},{reductions,11829187},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,67872},{total_heap_size,8370},{heap_size,...},{...}|...]
2025-03-08T12:10:11.661470+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.29411.3>, info: [{timeout,258}, {in, {cowboy_http, terminate_linger_loop,2}}, {out,{proc_lib,exit_p,3}}], undefined
2025-03-08T12:10:11.781123+08:00 [warning] [SYSMON] long_schedule warning: pid = <0.3098.0>, info: [{timeout,510}, {in, {emqx_connection,recvloop,2}}, {out, {emqx_connection,recvloop, 2}}], [{initial_call,{proc_lib,init_p,5}},{current_function,{emqx_connection,recvloop,2}},{registered_name,[]},{status,waiting},{message_queue_len,0},{group_leader,<0.1552.0>},{priority,normal},{trap_exit,false},{reductions,2951307},{last_calls,false},{catchlevel,1},{trace,0},{suspending,[]},{sequential_trace_token,[]},{error_handler,error_handler},{memory,13960},{total_heap_size,1604},{heap_size,...},{...}|...]
2025-03-08T12:10:11.891513+08:00 [warning] [SYSMON] long_schedule warning: port = #Port<0.309>, info: [{timeout,498}, {port_op,input}], [{name,"tcp_inet"},{links,[<0.3482.0>]},{id,2472},{connected,<0.3482.0>},{input,0},{output,5986},{os_pid,undefined}]
2025-03-08T12:10:11.891882+08:00 [warning] [SYSMON] long_schedule warning: port = #Port<0.34437>, info: [{timeout,479}, {port_op,input}], undefined