Zrywanie sesji PPPoE w godzinach 1-5, możliwy restart OLT - log routera ZTE F660

2023-03-27T01:09:28Z [Informational] fsm_close Interface ppp0, fsm: 0, state: 1, reason: LCP down(pppd:1619)
2023-03-27T01:09:31Z [Informational] Connection terminated.(pppd:1619)
2023-03-27T01:09:31Z [Informational] Modem hangup(pppd:1619)
2023-03-27T01:09:32Z [Notice] sendprogstop: pppd[1619]  died  exit_code = 16 exit_status = 1
2023-03-27T01:09:32Z [Informational] start program successful! cmd="pppd sendpadt XX:XX:XX:XX:XX 8484 nbif1"
2023-03-27T01:09:32Z [Debug] cmd is pppd sendpadt XX:XX:XX:XX:XX 8484 nbif1
2023-03-27T01:09:32Z [Informational] Sent PADT: XX:XX:XX:XX:XX, 8484(pppd:1682)
2023-03-27T01:09:32Z [Debug] cmd is pppd 0 oe normal file /var/tmp/ppp/options.oe0 nbif1
2023-03-27T01:09:32Z [Informational] start program successful! cmd="pppd 0 oe normal file /var/tmp/ppp/options.oe0 nbif1", pid=1683, inst=IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:32Z [Informational] Recv Event:V4 IGD.WD1.WCD1.WCPPP2 rcv EV_APP_PROTOCAL_DOWN on STATE_CONNECTED
2023-03-27T01:09:32Z [Informational] InitAppComm successful! inst:0, encaps:0, diag:0(pppd:1683)
2023-03-27T01:09:32Z [Informational] fsm_open calling callback for starting,unit=0,prot=0xc021(pppd:1683)
2023-03-27T01:09:32Z [Informational] start Discovery(pppd:1683)
2023-03-27T01:09:32Z [Informational] send PADI(pppd:1683)
2023-03-27T01:09:32Z [Warning] {DB_Csp_DownMsgProc} type: 1, VIEW:[IGD.WD1.WCD1.WCPPP2]
2023-03-27T01:09:32Z [Informational] recv PADO(pppd:1683)
2023-03-27T01:09:32Z [Informational] send PADR(pppd:1683)
2023-03-27T01:09:32Z [Debug] cmd is ip rule delete from 139.168.204.249 table 11 pref 20007
2023-03-27T01:09:32Z [Informational] voip Protocal socketv4 is [21],socketv6 is [0]
2023-03-27T01:09:32Z [Informational] voip Protocal Socket Init num is 1,Ipv4[0x0],Ipv6[::]!
2023-03-27T01:09:32Z [Informational] voip Protocal[SIP] Port[5060]create socket:Dscp[0],EthPri[-1],QueueNum[15]!
2023-03-27T01:09:32Z [Informational] voip [Num is 0]Protocal[SIP] PID[133377] create socket:socketv4 fd[0],socketv6 fd[0]!
2023-03-27T01:09:32Z [Informational] voip EXT[1], VoIP[1], DXO[0], FXO[0]
2023-03-27T01:09:32Z [Informational] voip DTMFTestTimer:200, FXOHookOffTimer:200, FXOHookOnTimer:200
2023-03-27T01:09:32Z [Informational] voip pidInfo RCA: 571
2023-03-27T01:09:32Z [Warning] receive EV_DB_HOT_RESTART message
2023-03-27T01:09:32Z [Informational] recv PADS, Session is 2189(pppd:1683)
2023-03-27T01:09:32Z [Debug] cmd is ip route flush cache
2023-03-27T01:09:32Z [Informational] info:delete current default route, clear it's variable!
2023-03-27T01:09:32Z [Informational] info:Not find the valid wan link for default route!
2023-03-27T01:09:32Z [Debug] Debug : pingMain, wState 1, wMsgtype 1, wEvent 9406
2023-03-27T01:09:32Z [Debug] Debug : pingProcASynMsg, wEvent 9406
2023-03-27T01:09:32Z [Informational] unknown ASynMsg!msg 37894
2023-03-27T01:09:32Z [Informational] fwSfSASynMsg wEvent:EV_WANLAN_UP/DEL/DOWN!
2023-03-27T01:09:32Z [Informational] ptWlanNotifier->ifType:WAN_TYPE
2023-03-27T01:09:32Z [Informational] Interface event:EV_WANLAN_DOWN VIEW_ID:IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:32Z [Informational] fwSchedule  wEvent:EV_WANLAN_DOWN pChViewNameID:IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:32Z [Debug] cmd is iptables -t nat -D dmzmapp -d 139.168.204.249 -j DNAT --to-destination 192.168.1.20 
2023-03-27T01:09:32Z [Debug] cmd is iptables -t filter -D dmzmapp -d 192.168.1.20 -j ACCEPT
2023-03-27T01:09:32Z [Debug] cmd is iptables -t nat -D snat -s 192.168.1.1/255.255.255.0 -d 192.168.1.1/255.255.255.0  -o br0 -j SNAT --to-source 139.168.204.249
2023-03-27T01:09:32Z [Informational] bas support lcp echo(pppd:1683)
2023-03-27T01:09:32Z [Informational] ptFwSchedule->wOpID:EV_FW_EVDWSCHEDULE chItemID:IGD.FWNAT.15
2023-03-27T01:09:32Z [Debug] cmd is iptables -t nat -D wansrcnat ! -s  139.168.204.249  -o ppp0 -j MASQUERADE
2023-03-27T01:09:32Z [Informational] fw WanInterfaceDwon !pChViewNameID:IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:32Z [Informational] fwSfSASynMsg wEvent:EV_INTERFACE_DOWN
2023-03-27T01:09:32Z [Debug] msg ptr:0x1e5448  event:37894
2023-03-27T01:09:32Z [Warning] parameter is illegal!repeat Reg Msg[00020101]
2023-03-27T01:09:32Z [Informational] unknown ASynMsg!msg id =39430
2023-03-27T01:09:32Z [Informational] Recv Event:V4 IGD.WD1.WCD1.WCPPP2 rcv EV_APP_PROTOCAL_UP on STATE_CONNECTING
2023-03-27T01:09:32Z [Debug] cmd is ip rule add from 52.14.4.253 table 11 pref 20007
2023-03-27T01:09:32Z [Debug] cmd is ip route flush cache
2023-03-27T01:09:32Z [Informational] strCmd is: ip route add 95.214.4.1/32 dev ppp0 src 52.14.4.253 table 11
2023-03-27T01:09:32Z [Debug] cmd is ip route add 52.14.4.1/32 dev ppp0 src 52.14.4.253 table 11
2023-03-27T01:09:33Z [Debug] cmd is ip route flush cache
2023-03-27T01:09:33Z [Informational] strCmd is: ip route add default via 52.14.4.253 dev ppp0 table 11
2023-03-27T01:09:33Z [Debug] cmd is ip route add default via 95.214.4.1 dev ppp0 table 11
2023-03-27T01:09:33Z [Debug] cmd is ip route flush cache
2023-03-27T01:09:33Z [Informational] strCmd is: ip route add default via 52.14.4.253 dev ppp0 table 254
2023-03-27T01:09:33Z [Debug] cmd is ip route add default via 95.214.4.1 dev ppp0 table 254
2023-03-27T01:09:33Z [Debug] cmd is ip route flush cache
2023-03-27T01:09:33Z [Warning] {DB_Csp_UpMsgProc} type: 1, VIEW:[IGD.WD1.WCD1.WCPPP2]
2023-03-27T01:09:33Z [Informational] voip IGD.WD1.WCD1.WCPPP2 change mode [0]->[1]
2023-03-27T01:09:33Z [Informational] voip WAN: [IGD.WD1.WCD1.WCPPP2], IP4: 5fd604fd, MASK: ffffffff
2023-03-27T01:09:33Z [Informational] fwSfSMain wMsgtype:SYN_REQ_MSG!
2023-03-27T01:09:33Z [Informational] fwSfSSynMsg wEvent:EV_FW_REGPORT/UNREGPORT!
2023-03-27T01:09:33Z [Informational] fwSfSMain wMsgtype:SYN_REQ_MSG!
2023-03-27T01:09:33Z [Informational] fwSfSSynMsg wEvent:EV_FW_REGPORT/UNREGPORT!
2023-03-27T01:09:33Z [Informational] fwScheduleUnRegister PortchItemID:IGD.FWPORT.VOIP0!
2023-03-27T01:09:33Z [Informational] fwScheduleUnRegister wEvent:EV_FW_UNREGSCHEDULE dwObjID:b0005 chItemID:IGD.FWPORT.VOIP0!
2023-03-27T01:09:33Z [Informational] ptFwSchedule->wOpID:EV_FW_EVDTSCHEDULE chItemID:IGD.FWPORT.VOIP0
2023-03-27T01:09:33Z [Debug] cmd is iptables -t nat -D fwports  -p UDP  --dport 4000:4012  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is iptables -t filter -D fwports  -p UDP  --dport 4000:4012  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is ip6tables -t filter -D fwports -p UDP  --dport 4000:4012  -j ACCEPT
2023-03-27T01:09:33Z [Informational] fwScheduleRegister PortchItemID:IGD.FWPORT.VOIP0!
2023-03-27T01:09:33Z [Informational] ptFwSchedule->wOpID:EV_FW_EVUPSCHEDULE chItemID:IGD.FWPORT.VOIP0
2023-03-27T01:09:33Z [Debug] cmd is iptables -t nat -I fwports  -p UDP  --dport 4000:4012  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is iptables -t filter -I fwports  -p UDP  --dport 4000:4012  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is ip6tables -t filter -I fwports -p UDP  --dport 4000:4012  -j ACCEPT
2023-03-27T01:09:33Z [Debug] Debug : pingMain, wState 1, wMsgtype 1, wEvent 9405
2023-03-27T01:09:33Z [Debug] Debug : pingProcASynMsg, wEvent 9405
2023-03-27T01:09:33Z [Informational] unknown ASynMsg!msg 37893
2023-03-27T01:09:33Z [Informational] fwSfSASynMsg wEvent:EV_WANLAN_UP/DEL/DOWN!
2023-03-27T01:09:33Z [Informational] ptWlanNotifier->ifType:WAN_TYPE
2023-03-27T01:09:33Z [Informational] Interface event:EV_WANLAN_UP VIEW_ID:IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:33Z [Informational] IP_ROUTED == tWancBaseInfo.ConnTypetViewName:IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:33Z [Informational] fwScheduleUnRegister NATchItemID:IGD.FWNAT.15
2023-03-27T01:09:33Z [Informational] fwScheduleUnRegister wEvent:EV_FW_UNREGSCHEDULE dwObjID:b0001 chItemID:IGD.FWNAT.15!
2023-03-27T01:09:33Z [Informational] ptFwSchedule->wOpID:EV_FW_EVDTSCHEDULE chItemID:IGD.FWNAT.15
2023-03-27T01:09:33Z [Informational] fwScheduleRegister NATchItemID:IGD.FWNAT.15 chOutViewNameID:IGD.WD1.WCD1.WCPPP2 isNat:1 isForward:1
2023-03-27T01:09:33Z [Informational] ptFwSchedule->wOpID:EV_FW_EVUPSCHEDULE chItemID:IGD.FWNAT.15
2023-03-27T01:09:33Z [Informational] VOIP->AGENT INFO:reg FW rtp: min[4000],max[4012]
2023-03-27T01:09:33Z [Debug] cmd is iptables -t nat -A wansrcnat ! -s  165.214.4.253  -o ppp0 -j MASQUERADE
2023-03-27T01:09:33Z [Informational] fwSchedule  wEvent:EV_WANLAN_UP pChViewNameID:IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:33Z [Debug] cmd is iptables -t nat -A dmzmapp -d 52.14.4.253 -j DNAT --to-destination 192.168.1.20 
2023-03-27T01:09:33Z [Debug] cmd is iptables -t filter -A dmzmapp -d 192.168.1.20 -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is iptables -t nat -A snat -s 192.168.1.1/255.255.255.0 -d 192.168.1.1/255.255.255.0  -o br0 -j SNAT --to-source 95.214.4.253
2023-03-27T01:09:33Z [Informational] fw WanInterfaceUp !pChViewNameID:IGD.WD1.WCD1.WCPPP2
2023-03-27T01:09:33Z [Informational] fwSfSMain wMsgtype:SYN_REQ_MSG!
2023-03-27T01:09:33Z [Informational] fwSfSSynMsg wEvent:EV_FW_REGPORT/UNREGPORT!
2023-03-27T01:09:33Z [Informational] fwSfSASynMsg wEvent:EV_INTERFACE_UP
2023-03-27T01:09:33Z [Debug] msg ptr:0x1e7f70  event:37893
2023-03-27T01:09:33Z [Error] get view failed VID(9) VN(IGD.WD1.WCD1.WCPPP2) Err(-5)
2023-03-27T01:09:33Z [Warning] call dbAPIGetView failed!chkDhcpWancType
2023-03-27T01:09:33Z [Warning] parameter is illegal!repeat Reg Msg[00020101]
2023-03-27T01:09:33Z [Informational] fwSfSMain wMsgtype:SYN_REQ_MSG!
2023-03-27T01:09:33Z [Informational] fwSfSSynMsg wEvent:EV_FW_REGPORT/UNREGPORT!
2023-03-27T01:09:33Z [Informational] fwScheduleUnRegister PortchItemID:IGD.FWPORT.SIP0!
2023-03-27T01:09:33Z [Informational] fwScheduleUnRegister wEvent:EV_FW_UNREGSCHEDULE dwObjID:b0005 chItemID:IGD.FWPORT.SIP0!
2023-03-27T01:09:33Z [Informational] ptFwSchedule->wOpID:EV_FW_EVDTSCHEDULE chItemID:IGD.FWPORT.SIP0
2023-03-27T01:09:33Z [Debug] cmd is iptables -t nat -D fwports  -p UDP  --dport 5060:5060  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is iptables -t filter -D fwports  -p UDP  --dport 5060:5060  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is ip6tables -t filter -D fwports -p UDP  --dport 5060:5060  -j ACCEPT
2023-03-27T01:09:33Z [Informational] fwScheduleRegister PortchItemID:IGD.FWPORT.SIP0!
2023-03-27T01:09:33Z [Informational] ptFwSchedule->wOpID:EV_FW_EVUPSCHEDULE chItemID:IGD.FWPORT.SIP0
2023-03-27T01:09:33Z [Debug] cmd is iptables -t nat -I fwports  -p UDP  --dport 5060:5060  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is iptables -t filter -I fwports  -p UDP  --dport 5060:5060  -j ACCEPT
2023-03-27T01:09:33Z [Debug] cmd is ip6tables -t filter -I fwports -p UDP  --dport 5060:5060  -j ACCEPT
2023-03-27T01:09:33Z [Informational] VOIP->AGENT INFO:sip: 5060
2023-03-27T01:09:33Z [Informational] voip Protocal socketv4 is [0],socketv6 is [0]
2023-03-27T01:09:33Z [Informational] voip Protocal Socket Init num is 1,Ipv4[0x5fd604fd],Ipv6[::]!
2023-03-27T01:09:33Z [Informational] voip Protocal[SIP] Port[5060]create socket:Dscp[0],EthPri[-1],QueueNum[15]!
2023-03-27T01:09:33Z [Informational] voip [Num is 0]Protocal[SIP] PID[133377] create socket:socketv4 fd[21],socketv6 fd[0]!
2023-03-27T01:09:33Z [Informational] voip EXT[1], VoIP[1], DXO[0], FXO[0]
2023-03-27T01:09:33Z [Informational] voip DTMFTestTimer:200, FXOHookOffTimer:200, FXOHookOnTimer:200
2023-03-27T01:09:33Z [Informational] voip pidInfo RCA: 571
2023-03-27T01:09:33Z [Warning] receive EV_DB_HOT_RESTART message