发消息时不时会重连,帮忙看下什么问题

lennon 2019-10-25 1270

安卓客户端发文本消息,会等待10S才发出去。查看日志,发现连接会断开重连。日志如下:

D/mars::stn: [longlink_task_manager.cc, StartTask, 83]:taskid=45  I/mars::proto: [stn_callback.cc, Req2Buf, 690]:PROTO -> TASK after package:taskid:45 cmdid:11 channel_id:0 channel_select:2 cgi:/im send_only:0 need_authed:1 limit_flow:0 limit_frequency:0 network_status_sensitive:0 channel_strategy:0 priority:3 retry_count:-1 server_process_cost:-1 total_timetout:-1     type:48topic:MS     body size:0  V/mars::stn: [anti_avalanche.cc, Check, 45]:-> Check      [frequency_limit.cc, Check, 46]:-> Check      [frequency_limit.cc, Check, 46]:<- Check +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::stn: [anti_avalanche.cc, Check, 45]:<- Check +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink_task_manager.cc, RunOnStartTask, 367]:task add into longlink readwrite suc cgi:/im, cmdid:11, taskid:45, size:2, timeout(firstpkg:12, rw:17, task:40), retry:1  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [socketbreaker.cc, Clear, 122]:Ret=-1  W/InputMethodManager: startInputReason = 3  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:-> stopAlarm   D/mars::comm: [platform_comm.cc, stopAlarm, 72]:id= 95, ret= true  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:<- stopAlarm +6,   I/mars::comm: [alarm.cc, Cancel, 90]:alarm cancel id:532137632776, seq:95, after:270000  V/mars::comm: [platform_comm.cc, startAlarm, 49]:-> startAlarm   D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 96, after= 270000, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +4,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532137632776, after:270000, seq:96, po.reg.q:531980240112,po.reg.s:0,po.s:865  D/mars::proto: [stn_callback.cc, TrafficData, 205]:send:72, recv:0  I/mars::stn: [longlink.cc, __RunReadWrite, 650]:task socket send sock:46, all send:72, count:1, sub send taskid:45, cmdid:11, /im, len(S:72, 72/72),   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +15,   V/mars::stn: [longlink_task_manager.cc, StartTask, 82]:<- StartTask +19,   V/mars::stn: [longlink_task_manager.cc, OnSend, 588]:-> OnSend   D/mars::stn: [longlink_task_manager.cc, OnSend, 596]:taskid:45, starttime:22901  V/mars::stn: [longlink_task_manager.cc, OnSend, 588]:<- OnSend +3,  

W/IInputConnectionWrapper: getTextBeforeCursor on inactive InputConnection 

W/IInputConnectionWrapper: getSelectedText on inactive InputConnection  W/IInputConnectionWrapper: getTextAfterCursor on inactive InputConnection 

V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,  

V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +5,  

V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +11,  

V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,  

V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +4,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,   D/JIGUANG-JCore-IMPL: [JCommonInterface] onEvent action:waked  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +4,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   E/mars::stn: [longlink_task_manager.cc, RunOnTimeout, 219]:task first-pkg timeout taskid:45,  nStartSendTime=22901, nfirstpkgtimeout=12  D/mars::stn: [dynamic_timeout.cc, StatusSwitch, 185]:task_status:-1, good_count:0, good_time:0, dyntime_status:3, dyntime_failed_normal_count_NORMAL:1, cgi:  V/mars::stn: [longlink_task_manager.cc, SingleRespHandle, 379]:-> SingleRespHandle   W/mars::stn: [longlink_task_manager.cc, SingleRespHandle, 424]:task end retry  long cmdid:11, err(6, -500, -1), svr(1.1.1.1:1111, BackupIP, 1.1.1.1), cli(, 1.1.1.1, n:"LT-QA", sig:0), cost(s:2, r:0, c:342, rw:12056), all:12078, retry:1, cgi:/im, taskid:45, tid:13572  V/mars::stn: [longlink_task_manager.cc, SingleRespHandle, 379]:<- SingleRespHandle +0,   I/mars::stn: [longlink.cc, Disconnect, 240]:_scene:10007  V/mars::comm: [dns.cc, Cancel, 283]:-> Cancel      [dns.cc, Cancel, 283]:<- Cancel +0,      [dns.cc, Cancel, 283]:-> Cancel      [dns.cc, Cancel, 283]:<- Cancel +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +1,   V/mars::comm: [platform_comm.cc, getCurWifiInfo, 241]:-> getCurWifiInfo   V/mars::comm: [platform_comm.cc, getCurWifiInfo, 241]:<- getCurWifiInfo +0,   W/mars::stn: [longlink.cc, RunReadWrite, 564]:task socket close sock:46, user disconnect:10007, nread:0, nwrite:72, net_type:"LT-QA", info nwrite:72 taskid:45, cmdid:11, cgi:/im ; task socket close getsocktcpinfo:tcpi_state=0x1, tcpi_ca_state=0x4, tcpi_retransmits=0x3, tcpi_probes=0x0, tcpi_backoff=0x3, tcpi_options=0x7, tcpi_rto=0x7DBB80, tcpi_snd_mss=0x4A4, tcpi_rcv_mss=0x218, tcpi_unacked=0x1, tcpi_sacked=0x0, tcpi_lost=0x1, tcpi_retrans=0x1, tcpi_fackets=0x0, tcpi_last_data_sent=0x1022, tcpi_last_ack_sent=0x0, tcpi_last_data_recv=0x10680, tcpi_last_ack_recv=0x1068A, tcpi_pmtu=0x5DC, tcpi_rcv_ssthresh=0x14820, tcpi_rtt=0x53333, tcpi_rttvar=0x1F496, tcpi_snd_ssthresh=0x7, tcpi_snd_cwnd=0x1, tcpi_advmss=0x56C, tcpi_reordering=0x3, tcpi_rcv_rtt=0x0, tcpi_rcv_space=0x14820, tcpi_total_retrans=0x  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:-> stopAlarm   D/mars::comm: [platform_comm.cc, stopAlarm, 72]:id= 96, ret= true  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:<- stopAlarm +14,   I/mars::comm: [alarm.cc, Cancel, 90]:alarm cancel id:532137632776, seq:96, after:270000  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getSignal, 387]:-> getSignal   V/mars::comm: [platform_comm.cc, getSignal, 397]:Signal Strength= 90, wifi:true     [platform_comm.cc, getSignal, 387]:<- getSignal +5,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink.cc, ConnectStatus, 345]:connect status from:2 to:3, nettype:1     [smart_heartbeat.cc, OnLongLinkDisconnect, 81]:-> OnLongLinkDisconnect   I/mars::stn: [smart_heartbeat.cc, OnLongLinkDisconnect, 94]:"LT-QA" not stable last heart:270000     [smart_heartbeat.cc, OnLongLinkDisconnect, 81]:<- OnLongLinkDisconnect +0,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x24C6, _timeout= 1000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,   I/mars::stn: [longlink.cc, Run, 374]:<- Run +67970,   I/mars::stn: [longlink.cc, Disconnect, 240]:_scene:10008  D/mars::stn: [net_check_logic.cc, UpdateLongLinkInfo, 118]:shortlink:_continueFailCount=1, _isTaskSucc=0, records=0xdb6fef76  I/mars::stn: [net_check_logic.cc, __ShouldNetCheck, 152]:netcheck: shortlink succ_count: 0, is most recent 8 times. valid_record_taskcount: 32.  I/mars::stn: [net_check_logic.cc, ShouldNetCheck, 159]:netcheck: shortlink_shouldcheck=false, shortlink succ_count=0, in sub-recent 8 times.   D/mars::stn: [net_source.cc, ReportLongIP, 239]:_is_success=false, ip=1.1.1.1, port=1899  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getCurWifiInfo, 241]:-> getCurWifiInfo      [platform_comm.cc, getCurWifiInfo, 241]:<- getCurWifiInfo +0,   D/mars::stn: [longlink_task_manager.cc, RunOnStartTask, 280]:retry interval:1000, curtime:22913495, lastbatcherrortime_:22913456, curtime-m_lastbatcherrortime:39  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::comm: [platform_comm.cc, startAlarm, 49]:-> startAlarm   D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 97, after= 500, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +5,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532225556472, after:500, seq:97, po.reg.q:531980240112,po.reg.s:0,po.s:882  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::stn: [timing_sync.cc, OnLongLinkStatuChanged, 96]:-> OnLongLinkStatuChanged   V/mars::appcomm: [com_tencent_mars_app_AppLogic_C2Java.cc, GetAccountInfo, 70]:-> GetAccountInfo   V/mars::appcomm: [com_tencent_mars_app_AppLogic_C2Java.cc, GetAccountInfo, 70]:<- GetAccountInfo +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, startAlarm, 49]:-> startAlarm   D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 98, after= 240000, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +5,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532227366464, after:240000, seq:98, po.reg.q:531980240112,po.reg.s:0,po.s:883  V/mars::stn: [timing_sync.cc, OnLongLinkStatuChanged, 96]:<- OnLongLinkStatuChanged +7,   I/mars::comm: [alarm.cc, OnAlarm, 131]:OnAlarm id:532225556472, seq:97, elapsed:501, after:500, miss:1, android alarm:false, runing  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::appcomm: [com_tencent_mars_app_AppLogic_C2Java.cc, GetAccountInfo, 70]:-> GetAccountInfo   V/mars::appcomm: [com_tencent_mars_app_AppLogic_C2Java.cc, GetAccountInfo, 70]:<- GetAccountInfo +0,   I/mars::stn: [longlink_connect_monitor.cc, __AutoIntervalConnect, 187]:start auto connect after:179522  V/mars::comm: [platform_comm.cc, startAlarm, 49]:-> startAlarm   D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 99, after= 179522, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +10,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532225556472, after:179522, seq:99, po.reg.q:531980240112,po.reg.s:0,po.s:886  V/mars::comm: [socketbreaker.cc, Clear, 122]:Ret=-1  I/mars::stn: [longlink_connect_monitor.cc, IntervalConnect, 173]:made interval connect interval:20000, posttime:68973, newone:true, connectstatus:0  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink.cc, Run, 374]:-> Run LongLink Rebuild span:0, net:1  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::comm: [platform_comm.cc, getCurWifiInfo, 241]:-> getCurWifiInfo      [platform_comm.cc, getCurWifiInfo, 241]:<- getCurWifiInfo +0,      [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x24C6, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink.cc, ConnectStatus, 345]:connect status from:0 to:1, nettype:1  V/mars::comm: [dns.cc, GetHostByName, 184]:-> GetHostByName   V/mars::comm: [platform_comm.cc, stopAlarm, 64]:-> stopAlarm   V/mars::comm: [dns.cc, GetIP, 59]:-> GetIP   V/mars::comm: [dns.cc, GetIP, 59]:<- GetIP +0,   I/mars::comm: [dns.cc, GetHostByName, 265]:dns get ip status:4 host:1.1.1.1, func:true  V/mars::comm: [dns.cc, GetHostByName, 184]:<- GetHostByName +2,      [dns.cc, GetHostByName, 184]:-> GetHostByName   V/mars::comm: [dns.cc, GetIP, 59]:-> GetIP   V/mars::comm: [dns.cc, GetIP, 59]:<- GetIP +1,   V/mars::comm: [dns.cc, GetHostByName, 184]:<- GetHostByName +3,   D/mars::stn: [net_source.cc, MakeIPPorts, 369]:link host:1.1.1.1, new dns ret:false, size:0 dns ret:true, size:1,  W/mars::stn: [simple_ipport_sort.cc, FilterbyBanned, 317]:ip:1.1.1.1, port:1899, is ban!!  D/mars::stn: [net_source.cc, MakeIPPorts, 398]:link host:1.1.1.1, backup ips size:1  I/mars::stn: [longlink.cc, RunConnect, 437]:task socket dns ip:1.1.1.1:1899:1.1.1.1:BackupIP proxytype:0 useproxy:false  I/mars::comm: [complexconnect.cc, ConnectImpatient, 453]:_vecaddr size:1, m_timeout:10000, m_interval:4000, m_error_interval:4000, m_max_connect:3, @0x7BE5DFE4E8  I/mars::comm: [complexconnect.cc, ConnectImpatient, 459]:complex.conn [::ffff:1.1.1.1]:1899  D/mars::comm: [complexconnect.cc, ConnectImpatient, 476]:curtime:22914516, laststart_connecttime:22910516, @0x7BE5DFE4E8  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   D/mars::comm: [platform_comm.cc, stopAlarm, 72]:id= 99, ret= true  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:<- stopAlarm +9,   I/mars::comm: [complexconnect.cc, ConnectImpatient, 518]:index:0, @0x7BE5DFE4E8, addr:(1.1.1.1:1899), socket:46, connect  I/mars::comm: [alarm.cc, Cancel, 90]:alarm cancel id:532225556472, seq:99, after:179522  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::stn: [timing_sync.cc, OnLongLinkStatuChanged, 96]:-> OnLongLinkStatuChanged   V/mars::stn: [timing_sync.cc, OnLongLinkStatuChanged, 96]:<- OnLongLinkStatuChanged +0,   I/mars::stn: [net_core.cc, ConnStatusCallBack, 726]:reportNetConnectInfo all_connstatus:3, longlink_connstatus:3  D/: status changed :0  D/mars::comm: [complexconnect.cc, ConnectImpatient, 522]:timeout:4000, @0x7BE5DFE4E8  I/MicroMsg.Alarm: [, , 0]:onReceive id=97, curId=97  I/MicroMsg.Alarm: [, , 0]:onReceive find alarm id:97, pid:11116, delta miss time:523  D/mars::comm: [OnAlarm.inl, Java_com_tencent_mars_comm_Alarm_onAlarm, 13]:BroadcastMessage seq:97  I/mars::comm: [complexconnect.cc, ConnectImpatient, 555]:index:0, @0x7BE5DFE4E8, sock:46, (1.1.1.1:1899), connected Rtt:322,   I/mars::comm: [complexconnect.cc, ConnectImpatient, 592]:index:0, sock:46, suc ConnectImpatient:1.1.1.1:1899, RTT:(322, 322), @0x7BE5DFE4E8     [complexconnect.cc, ConnectImpatient, 628]:retsocket:46, connrtt:322, conntotalrtt:322, totalcost:323, @0x7BE5DFE4E8  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink.cc, RunConnect, 537]:task socket connect suc sock:46, host:1.1.1.1, ip:1.1.1.1, port:1899, local_ip:1.1.1.1, local_port:60084, iptype:BackupIP, costtime:323, rtt:322, totalcost:322, index:0, net:1  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink.cc, ConnectStatus, 345]:connect status from:1 to:2, nettype:1  D/mars::stn: [smart_heartbeat.cc, OnLongLinkEstablished, 74]:-> OnLongLinkEstablished   I/mars::stn: [smart_heartbeat.cc, LoadINI, 284]:-> LoadINI   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getCurWifiInfo, 241]:-> getCurWifiInfo      [platform_comm.cc, getCurWifiInfo, 241]:<- getCurWifiInfo +0,   I/mars::stn: [smart_heartbeat.cc, LoadINI, 284]:<- LoadINI +0,   D/mars::stn: [smart_heartbeat.cc, OnLongLinkEstablished, 74]:<- OnLongLinkEstablished +0,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x24C6, _timeout= 1000  I/mars::stn: [longlink_connect_monitor.cc, OnLongLinkStatuChanged, 221]:cancel auto connect  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +1,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   I/mars::stn: [alarm.h, Alarm, 55]:handler:(531980240112,897)  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [alarm.h, Alarm, 55]:handler:(531980240112,899)  I/mars::proto: [stn_callback.cc, Req2Buf, 690]:PROTO -> TASK after package:taskid:45 cmdid:11 channel_id:0 channel_select:2 cgi:/im send_only:0 need_authed:1 limit_flow:0 limit_frequency:0 network_status_sensitive:0 channel_strategy:0 priority:3 retry_count:-1 server_process_cost:-1 total_timetout:-1     type:48topic:MS     body size:0  V/mars::comm: [platform_comm.cc, startAlarm, 49]:-> startAlarm   V/mars::stn: [anti_avalanche.cc, Check, 45]:-> Check      [frequency_limit.cc, Check, 46]:-> Check      [frequency_limit.cc, Check, 46]:<- Check +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::stn: [anti_avalanche.cc, Check, 45]:<- Check +1,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink_task_manager.cc, RunOnStartTask, 367]:task add into longlink readwrite suc cgi:/im, cmdid:11, taskid:45, size:2, timeout(firstpkg:12, rw:17, task:40), retry:0  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 100, after= 5000, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +9,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532137632936, after:5000, seq:100, po.reg.q:531980240112,po.reg.s:0,po.s:901  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x24C6, _timeout= 5000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,   V/mars::stn: [timing_sync.cc, OnLongLinkStatuChanged, 96]:-> OnLongLinkStatuChanged   V/mars::comm: [platform_comm.cc, stopAlarm, 64]:-> stopAlarm   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::stn: [smart_heartbeat.cc, OnHeartbeatStart, 64]:-> OnHeartbeatStart      [smart_heartbeat.cc, OnHeartbeatStart, 64]:<- OnHeartbeatStart +0,   D/mars::comm: [platform_comm.cc, stopAlarm, 72]:id= 98, ret= true  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:<- stopAlarm +8,   I/mars::comm: [alarm.cc, Cancel, 90]:alarm cancel id:532227366464, seq:98, after:240000  V/mars::stn: [timing_sync.cc, OnLongLinkStatuChanged, 96]:<- OnLongLinkStatuChanged +9,   I/mars::stn: [zombie_task_manager.cc, RedoTasks, 117]:-> RedoTasks   V/mars::comm: [platform_comm.cc, startAlarm, 49]:-> startAlarm   I/mars::stn: [zombie_task_manager.cc, RedoTasks, 117]:<- RedoTasks +0,      [net_core.cc, ConnStatusCallBack, 726]:reportNetConnectInfo all_connstatus:4, longlink_connstatus:4  D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 101, after= 270000, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +6,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532137632776, after:270000, seq:101, po.reg.q:531980240112,po.reg.s:0,po.s:903  I/mars::stn: [longlink.cc, RunReadWrite, 572]:start noop synccheck taskid:4294967294, cmdid:10,  last:(0,0), next:270000  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:-> stopAlarm   D/mars::comm: [platform_comm.cc, stopAlarm, 72]:id= 101, ret= true  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:<- stopAlarm +8,   I/mars::comm: [alarm.cc, Cancel, 90]:alarm cancel id:532137632776, seq:101, after:270000  V/mars::comm: [platform_comm.cc, startAlarm, 49]:-> startAlarm   D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 102, after= 270000, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +7,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532137632776, after:270000, seq:102, po.reg.q:531980240112,po.reg.s:0,po.s:904  D/mars::proto: [stn_callback.cc, TrafficData, 205]:send:188, recv:0  I/mars::stn: [longlink.cc, RunReadWrite, 650]:task socket send sock:46, all send:188, count:2, sub send taskid:4294967294, cmdid:10, , len(S:116, 116/116), sub send taskid:45, cmdid:11, /im, len(S:72, 72/72),   V/mars::stn: [longlink_task_manager.cc, OnSend, 588]:-> OnSend   V/mars::stn: [longlink_task_manager.cc, OnSend, 588]:<- OnSend +0,      [longlink_task_manager.cc, OnSend, 588]:-> OnSend   D/mars::stn: [longlink_task_manager.cc, OnSend, 596]:taskid:45, starttime:22914  V/mars::stn: [longlink_task_manager.cc, OnSend, 588]:<- OnSend +0,   V/mars::comm: [socketbreaker.cc, Clear, 122]:Ret=-1  D/mars::proto: [stn_callback.cc, TrafficData, 205]:send:0, recv:74  I/mars::stn: [longlink.cc, RunReadWrite, 740]:task socket recv sock:46, recv len:74, buff len:74     [longlink.cc, RunReadWrite, 759]:task socket recv sock:46, pack recv finish taskid:4294967294, cmdid:10, , packlen:(37/37)  I/mars::stn: [longlink.cc, NoopResp, 300]:end noop synccheck     [longlink_identify_checker.cc, OnIdentifyResp, 79]:identifycheck(synccheck) resp  D/: status changed :2  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:-> stopAlarm   I/mars::stn: [net_core.cc, operator, 299]:task start long short taskid:46, cmdid:11, need_authed:true, cgi:, channel_select:2, limit_flow:false, host:, send_only:false, cmdid:11, server_process_cost:-1, retrycount:-1,  channel_strategy:0,  total_timetout:-1, network_status_sensitive:false, priority:3, report_arg:  V/mars::stn: [longlink_task_manager.cc, StartTask, 82]:-> StartTask   D/mars::stn: [longlink_task_manager.cc, StartTask, 83]:taskid=46  I/mars::proto: [stn_callback.cc, Req2Buf, 690]:PROTO -> TASK after package:taskid:46 cmdid:11 channel_id:0 channel_select:2 cgi: send_only:0 need_authed:1 limit_flow:0 limit_frequency:0 network_status_sensitive:0 channel_strategy:0 priority:3 retry_count:-1 server_process_cost:-1 total_timetout:-1     type:48topic:MP     body size:12  V/mars::stn: [anti_avalanche.cc, Check, 45]:-> Check      [frequency_limit.cc, Check, 46]:-> Check   V/mars::stn: [frequency_limit.cc, Check, 46]:<- Check +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::stn: [anti_avalanche.cc, Check, 45]:<- Check +1,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink_task_manager.cc, RunOnStartTask, 367]:task add into longlink readwrite suc cgi:, cmdid:11, taskid:46, size:2, timeout(firstpkg:13, rw:18, task:40), retry:1  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::stn: [longlink_task_manager.cc, StartTask, 82]:<- StartTask +9,   D/mars::comm: [platform_comm.cc, stopAlarm, 72]:id= 100, ret= true  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:<- stopAlarm +12,   I/mars::comm: [alarm.cc, Cancel, 90]:alarm cancel id:532137632936, seq:100, after:5000  D/mars::stn: [net_check_logic.cc, UpdateLongLinkInfo, 118]:shortlink:_continueFailCount=1, _isTaskSucc=1, records=0xb6dfdeed  D/mars::stn: [smart_heartbeat.cc, OnHeartResult, 106]:heart result:true, false  I/mars::stn: [net_check_logic.cc, ShouldNetCheck, 152]:netcheck: shortlink succ_count: 0, is most recent 8 times. valid_record_taskcount: 32.     [net_check_logic.cc, ShouldNetCheck, 159]:netcheck: shortlink_shouldcheck=false, shortlink succ_count=0, in sub-recent 8 times.      [zombie_task_manager.cc, RedoTasks, 117]:-> RedoTasks   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout   I/mars::stn: [zombie_task_manager.cc, RedoTasks, 117]:<- RedoTasks +0,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x24C6, _timeout= 500  D/mars::stn: [net_source.cc, ReportLongIP, 239]:_is_success=true, ip=1.1.1.1, port=1899  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   I/mars::stn: [longlink.cc, RunReadWrite, 759]:task socket recv sock:46, pack recv finish taskid:45, cmdid:11, /im, packlen:(37/37)  V/mars::comm: [platform_comm.cc, getCurWifiInfo, 241]:-> getCurWifiInfo   V/mars::comm: [platform_comm.cc, getCurWifiInfo, 241]:<- getCurWifiInfo +0,   V/mars::comm: [platform_comm.cc, stopAlarm, 64]:-> stopAlarm   I/mars::proto: [stn_callback.cc, Buf2Resp, 725]:PROTO -> TASK(taskid:45 cmdid:11 channel_id:0 channel_select:2 cgi:/im send_only:0 need_authed:1 limit_flow:0 limit_frequency:0 network_status_sensitive:0 channel_strategy:0 priority:3 retry_count:-1 server_process_cost:-1 total_timetout:-1     type:48topic:MS     body size:0) has response  I/mars::proto: [stn_callback.cc, Buf2Resp, 726]:PROTO -> TASK errorcode:0     [stn_callback.cc, Buf2Resp, 734]:PROTO -> TASK business code:0(0success, otherwise failure)  D/mars::comm: [platform_comm.cc, stopAlarm, 72]:id= 102, ret= true  V/mars::comm: [platform_comm.cc, stopAlarm, 64]:<- stopAlarm +7,   I/mars::comm: [alarm.cc, Cancel, 90]:alarm cancel id:532137632776, seq:102, after:270000  V/mars::comm: [platform_comm.cc, startAlarm, 49]:-> startAlarm   D/mars::comm: [platform_comm.cc, startAlarm, 58]:id= 103, after= 270000, ret= true  V/mars::comm: [platform_comm.cc, startAlarm, 49]:<- startAlarm +4,   I/mars::comm: [alarm.cc, Start, 67]:alarm id:532137632776, after:270000, seq:103, po.reg.q:531980240112,po.reg.s:0,po.s:911  D/mars::proto: [stn_callback.cc, TrafficData, 205]:send:40, recv:0  I/mars::stn: [longlink.cc, __RunReadWrite, 650]:task socket send sock:46, all send:40, count:1, sub send taskid:46, cmdid:11, , len(S:40, 40/40),   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,   D/mars::stn: [dynamic_timeout.cc, StatusSwitch, 185]:task_status:1, good_count:0, good_time:0, dyntime_status:3, dyntime_failed_normal_count_NORMAL:2, cgi:/im  V/mars::stn: [longlink_task_manager.cc, SingleRespHandle, 379]:-> SingleRespHandle   I/mars::stn: [longlink_task_manager.cc, SingleRespHandle, 399]:task end callback  long cmdid:11, err(0, 0, 0), svr(1.1.1.1:1899, BackupIP, 1.1.1.1), cli(, 1.1.1.1, n:"LT-QA", sig:0), cost(s:2, r:17, c:322, rw:375), all:13890, retry:0, cgi:/im, taskid:45, tid:13665  V/mars::stn: [longlink_task_manager.cc, SingleRespHandle, 379]:<- SingleRespHandle +0,   D/mars::stn: [net_check_logic.cc, UpdateLongLinkInfo, 118]:shortlink:_continueFailCount=0, _isTaskSucc=1, records=0x6dbfbddb  I/mars::stn: [net_check_logic.cc, ShouldNetCheck, 152]:netcheck: shortlink succ_count: 0, is most recent 8 times. valid_record_taskcount: 32.     [net_check_logic.cc, __ShouldNetCheck, 159]:netcheck: shortlink_shouldcheck=false, shortlink succ_count=0, in sub-recent 8 times.      [zombie_task_manager.cc, RedoTasks, 117]:-> RedoTasks      [zombie_task_manager.cc, RedoTasks, 117]:<- RedoTasks +0,   D/mars::stn: [net_source.cc, ReportLongIP, 239]:_is_success=true, ip=1.1.1.1, port=1899  V/mars::comm: [platform_comm.cc, getNetInfo, 131]:-> getNetInfo   V/mars::comm: [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getNetInfo, 131]:-> getNetInfo      [platform_comm.cc, getNetInfo, 131]:<- getNetInfo +0,      [platform_comm.cc, getCurWifiInfo, 241]:-> getCurWifiInfo      [platform_comm.cc, getCurWifiInfo, 241]:<- getCurWifiInfo +0,   V/mars::stn: [longlink_task_manager.cc, OnSend, 588]:-> OnSend   D/mars::stn: [longlink_task_manager.cc, OnSend, 596]:taskid:46, starttime:22915  V/mars::stn: [longlink_task_manager.cc, OnSend, 588]:<- __OnSend +0,  

V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +3,   V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:-> wakeupLock_Lock_Timeout      [platform_comm.cc, wakeupLock_Lock_Timeout, 479]:_object= 0x2476, _timeout= 30000  V/mars::comm: [platform_comm.cc, wakeupLock_Lock_Timeout, 476]:<- wakeupLock_Lock_Timeout +2,

最新回复 (4)
  • HeavyRain 2019-10-25
    引用 2
    请确保使用我们发布的服务端和客户端测试。我们不建议客户修改服务端代码,如果你们修改了我们就无法提供技术支持
  • lennon 2019-10-29
    引用 3
    在你们发布的代码上面做的二次开发。后面我用你们发布的没改过的代码再试,也有一样的问题……
  • lennon 2019-10-29
    引用 4

    这个是日志

    上传的附件:
  • lennon 2019-10-29
    引用 5
    HeavyRain 请确保使用我们发布的服务端和客户端测试。我们不建议客户修改服务端代码,如果你们修改了我们就无法提供技术支持
    -。-
返回