search

Tencent / mars

Mars is a cross-platform network component developed by WeChat.
Other
17.32k stars 3.63k forks source link

xlog pid 不变情况下，日志丢失 #728

Open zjackcoder opened 4 years ago

zjackcoder commented 4 years ago

华为p20 pro 手机 11:49:07至11:49:26, 有10秒左右的日志缺失 @rocklau @king6cong @simpleton @bennyn @hzlzh 日志如下

^^^^^^^^^^Oct 10 2019^^^16:55:22^^^^^^^^^^[3153,3153][2019-11-22 +0800 11:49:07] get mmap time: 16 MARS_URL: MARS_PATH: MARS_REVISION: MARS_BUILD_TIME: 2019-07-04 17:41:14 MARS_BUILD_JOB: log appender mode:0, use mmap:1 cache dir space info, capacity:55425040384 free:17272311808 available:17121316864 log dir space info, capacity:55425040384 free:17272311808 available:17121316864


[I][2019-11-22 +8.0 11:49:07.842][3153, 3153*][mars::stn][net_source.cc, SetLongLink, 96][task set longlink server addr, host:cr.xxxxhh.com port:18082 debugip:
[I][2019-11-22 +8.0 11:49:07.842][3153, 3153*][mars::stn][net_source.cc, SetShortlink, 119][task set shortlink server addr, port:18081, debugip:
[I][2019-11-22 +8.0 11:49:07.842][3153, 3153*][mars::stn][net_source.cc, SetBackupIPs, 128][task set backup server addr, host:cr.xxxxhh.comip:121.41.23.233 
[I][2019-11-22 +8.0 11:49:07.842][3153, 3153*][mars::stn][stn_logic.cc, onCreate, 87][stn oncreate
[I][2019-11-22 +8.0 11:49:07.842][3153, 3153*][mars::comm][message_queue.cc, CreateMessageQueue, 930][create messageqeue id:18446744072774982000
[I][2019-11-22 +8.0 11:49:07.842][3153, 3153*][mars::baseevent][alarm.h, Alarm, 56][handler:(18446744072774982000,2)
[I][2019-11-22 +8.0 11:49:07.842][3153, 3346][mars::comm][message_queue.cc, Run, 775][-> Run messagequeue id:18446744072774982000
[I][2019-11-22 +8.0 11:49:07.842][3153, 3153*][mars::baseevent][active_logic.cc, ActiveLogic, 48][-> ActiveLogic 
[I][2019-11-22 +8.0 11:49:07.844][3153, 2*][MicroMsg.Alarm][com.tencent.mars.comm.Alarm, start, 73][start new wakerlock
[I][2019-11-22 +8.0 11:49:07.846][3153, 3153*][mars::comm][alarm.cc, Start, 68][alarm id:3706988512, after:600000, seq:1, po.reg.q:18446744072774982000,po.reg.s:0,po.s:4
[I][2019-11-22 +8.0 11:49:07.846][3153, 3153*][mars::baseevent][active_logic.cc, ActiveLogic, 48][<- ActiveLogic +4, 
[I][2019-11-22 +8.0 11:49:07.846][3153, 3153*][mars::comm][message_queue.cc, CreateMessageQueue, 930][create messageqeue id:18446744072773945712
[I][2019-11-22 +8.0 11:49:07.850][3153, 3350][mars::comm][message_queue.cc, Run, 775][-> Run messagequeue id:18446744072773945712
[I][2019-11-22 +8.0 11:49:07.850][3153, 3153*][mars::stn][net_source.cc, NetSource, 83][-> NetSource 
[I][2019-11-22 +8.0 11:49:07.850][3153, 3153*][mars::stn][net_source.cc, NetSource, 83][<- NetSource +0, 
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::stn][net_check_logic.cc, NetCheckLogic, 106][-> NetCheckLogic 
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::stn][net_check_logic.cc, NetCheckLogic, 106][<- NetCheckLogic +0, 
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::comm][wakeuplock.cc, WakeUpLock, 32][new wakeuplock:0x364a
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::stn][shortlink_task_manager.cc, ShortLinkTaskManager, 58][-> ShortLinkTaskManager handler:(18446744072773945712,7)
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::stn][shortlink_task_manager.cc, ShortLinkTaskManager, 59][ShortLinkTaskManager messagequeue_id=18446744072773945712
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::stn][shortlink_task_manager.cc, ShortLinkTaskManager, 58][<- ShortLinkTaskManager +0, 
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::stn][zombie_task_manager.cc, ZombieTaskManager, 48][handler:(18446744072773945712,8)
[I][2019-11-22 +8.0 11:49:07.851][3153, 3153*][mars::stn][smart_heartbeat.cc, SmartHeartbeat, 59][-> SmartHeartbeat 
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][smart_heartbeat.cc, SmartHeartbeat, 59][<- SmartHeartbeat +1, 
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::comm][wakeuplock.cc, WakeUpLock, 32][new wakeuplock:0x3656
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][longlink.cc, LongLink, 147][handler:(18446744072773945712,10)
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][alarm.h, Alarm, 73][handler:(18446744072773945712,12)
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][longlink_connect_monitor.cc, LongLinkConnectMonitor, 121][handler:(18446744072773945712,11)
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::comm][wakeuplock.cc, WakeUpLock, 32][new wakeuplock:0x3666
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][longlink_task_manager.cc, LongLinkTaskManager, 61][-> LongLinkTaskManager handler:(18446744072773945712,9)
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][longlink_task_manager.cc, LongLinkTaskManager, 61][<- LongLinkTaskManager +0, 
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][signalling_keeper.cc, SignallingKeeper, 48][SignallingKeeper messagequeue_id=18446744072773945712, handler:(18446744072773945712,14)
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][netsource_timercheck.cc, NetSourceTimerCheck, 52][handler:(18446744072773945712,15)
[I][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::stn][alarm.h, Alarm, 56][handler:(18446744072774982000,17)
[W][2019-11-22 +8.0 11:49:07.853][3153, 3153*][mars::app][com_tencent_mars_app_AppLogic_C2Java.cc, GetAccountInfo, 81][getAccountInfo null
[I][2019-11-22 +8.0 11:49:07.856][3153, 3153*][mars::comm][alarm.cc, Start, 68][alarm id:3706988960, after:240000, seq:2, po.reg.q:18446744072774982000,po.reg.s:0,po.s:19
[W][2019-11-22 +8.0 11:49:07.856][3153, 3153*][mars::stn][net_core.cc, NetCore, 121][publiccomponent version: Oct 10 2019 16:55:44
[I][2019-11-22 +8.0 11:49:07.856][3153, 3153*][mars::stn][net_core.cc, NetCore, 123][netcore messagequeue_id=18446744072773945712, handler:(18446744072773945712,6)
[W][2019-11-22 +8.0 11:49:07.859][3153, 3153*][mars::app][com_tencent_mars_app_AppLogic_C2Java.cc, GetAccountInfo, 81][getAccountInfo null
[W][2019-11-22 +8.0 11:49:07.859][3153, 3153*][mars::stn][net_core.cc, NetCore, 148][
ISP_NAME : 中国移动
ISP_CODE : 46002
ClientVersion :0x5F5E100
[I][2019-11-22 +8.0 11:49:07.859][3153, 3153*][mars::stn][net_core.cc, NetCore, 159][-> NetCore 
[I][2019-11-22 +8.0 11:49:07.859][3153, 3153*][mars::stn][net_core.cc, NetCore, 159][<- NetCore +0, 
[I][2019-11-22 +8.0 11:49:07.859][3153, 3153*][mars::sdt][sdt_logic.cc, onCreate, 46][sdt oncreate
[I][2019-11-22 +8.0 11:49:07.859][3153, 3153*][mars::sdt][sdt_core.cc, SdtCore, 46][-> SdtCore 
[I][2019-11-22 +8.0 11:49:07.859][3153, 3153*][mars::sdt][sdt_core.cc, SdtCore, 46][<- SdtCore +0, 
[I][2019-11-22 +8.0 11:49:07.867][3153, 3350][mars::comm][local_routetable.cc, get_local_route_table, 20][popen cmd=ip route list table all
[I][2019-11-22 +8.0 11:49:07.914][3153, 3350][mars::stn][net_core.cc, operator, 154][net info:current network:wifi, ssid:"H_5G",ipstack:ELocalIPStack_IPv4
--------NetConfig Info----------
getdefaultgateway6:failed. getdefaultgateway:failed. ----------route table----------
default dev dummy0  table 1003  proto static  scope link 
192.168.168.0/24 dev wlan0  proto kernel  scope link  src 192.168.168.129 
default via 192.168.168.1 dev wlan0  table 1023  proto static 
192.168.168.0/24 dev wlan0  table 1023  proto static  scope link 
broadcast 127.0.0.0 dev lo  table local  proto kernel  scope link  src 127.0.0.1 
local 127.0.0.0/8 dev lo  table local  proto kernel  scope host  src 127.0.0.1 
local 127.0.0.1 dev lo  table local  proto kernel  scope host  src 127.0.0.1 
broadcast 127.255.255.255 dev lo  table local  proto kernel  scope link  src 127.0.0.1 
broadcast 192.168.168.0 dev wlan0  table local  proto kernel  scope link  src 192.168.168.129 
local 192.168.168.129 dev wlan0  table local  proto kernel  scope host  src 192.168.168.129 
broadcast 192.168.168.255 dev wlan0  table local  proto kernel  scope link  src 192.168.168.129 
fe80::/64 dev dummy0  table 1003  proto kernel  metric 256  pref medium
default dev dummy0  table 1003  proto static  metric 1024  pref medium
fe80::/64 dev rmnet_data0  table 1006  proto kernel  metric 256  mtu 1410 pref medium
2409:8809:9ab2:1c70::/64 dev rmnet_data2  table 1008  proto kernel  metric 256  pref medium
fe80::/64 dev rmnet_data2  table 1008  proto kernel  metric 256  pref medium
default via fe80::60ae:743c:ab4b:40ef dev rmnet_data2  table 1008  proto ra  metric 1024  expires 63688sec hoplimit 64 pref medium
fe80::/64 dev wlan0  table 1023  proto kernel  metric 256  pref medium
fe80::/64 dev wlan0  table 1023  proto static  metric 1024  pref medium
local ::1 dev lo  table local  proto none  metric 0  pref medium
local 2409:8809:9ab2:1c70:f0fe:8da4:b164:cf64 dev lo  table local  proto none  metric 0  pref medium
local fe80::9ff2:28f2:67fd:9c43 dev lo  table local  proto none  metric 0  pref medium
local fe80::e646:daff:fe6b:8468 dev lo  table local  proto none  metric 0  pref medium
local fe80::f0fe:8da4:b164:cf64 dev lo  table local  proto none  metric 0  pref medium
local fe80::fcf6:53ff:feef:d3ca dev lo  table local  proto none  metric 0  pref medium
ff00::/8 dev dummy0  table local  metric 256  pref medium
ff00::/8 dev rmnet_data0  table local  metric 256  mtu 1410 pref medium
ff00::/8 dev rmnet_data2  table local  metric 256  pref medium
ff00::/8 dev wlan0  table local  metric 256  pref medium
----------NIC Info-----------
interface name:wlan0, AF_INET, ip:192.168.168.129
interface name:dummy0, AF_INET6, ip:fe80::fcf6:53ff:feef:d3ca
interface name:rmnet_data0, AF_INET6, ip:fe80::9ff2:28f2:67fd:9c43
interface name:rmnet_data2, AF_INET6, ip:2409:8809:9ab2:1c70:f0fe:8da4:b164:cf64
interface name:rmnet_data2, AF_INET6, ip:fe80::f0fe:8da4:b164:cf64
interface name:wlan0, AF_INET6, ip:fe80::e646:daff:fe6b:8468
[I][2019-11-22 +8.0 11:49:26.645][3153, 3723][ServiceStub][com.wjhd.im.service.l, a, 169][now start task with id 1
[I][2019-11-22 +8.0 11:49:26.646][3153, 3350][mars::stn][net_core.cc, operator, 298][task start long short taskid:1, cmdid:1001, need_authed:true, cgi:/base/service/chatroom/enter, channel_select:3, limit_flow:true, host:cr.x x x xhh.com, send_only:false, cmdid:1001, server_process_cost:0, retrycount:-1,  channel_strategy:0,  total_timetout:0, network_status_sensitive:false, priority:3, report_arg:
[I][2019-11-22 +8.0 11:49:28.649][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:31.651][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:39.673][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:41.680][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:42.683][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:43.685][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:45.691][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:47.699][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:49.703][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:51.706][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:52.708][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:53.711][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:54.716][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
[I][2019-11-22 +8.0 11:49:58.726][3153, 3350][mars::stn][shortlink_task_manager.cc, __RunOnStartTask, 259][makeSureAuth retsult=false
~~~~~ end of mmap ~~~~~[4439,4439][2019-11-22 +0800 11:50:02]
wlssing commented 4 years ago

我也出现了 但是并不是丢失 是日志换了个文件打了 就是 A B C 三个日志文件 A和B都打完了 这时候C日志没满 有时候重启 日志跑到A和B中了