Internet dropping out at 2am each morning

Discussions for BiPAC 8900 series: 8900AX-1600, 8900AX-2400, 8900X
Post Reply
kevftw
Posts: 3
Joined: Fri Dec 20, 2019 3:03 am

Internet dropping out at 2am each morning

Post by kevftw » Sat Jun 06, 2020 2:20 am

Hi all,

This might be something entirely ISP side so I'll be enquiring with them as well, but I was hoping someone might be able to glance over the logs below from my router when the connection is dropping out and see if there's anything relevant that might be to do with the router or my setup.

The problem as in the title, is basically between 02:00 and 02:06 so far, almost every day, the internet will drop out for 2-3 mins and then continue as normal. Not the end of the world obviously but if I'm still online at that time or downloading something it's a pain.

I've tried updating the firmware to 2.52.d41 which included the reset with factory defaults option but doesn't seem to have made any difference.


Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: SILI Start - UtopiaCfg - 10
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: AutoSenseATM is not enabled. Link Traffic type from PHY=1
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: XTM Link Information, port = 0, State = DOWN(2), Service Support = ATM(1)
Jun 6 02:06:17 kern warn kernel: Calling SetLinkInfo 1
Jun 6 02:06:17 kern warn kernel: HOST XTM tx ch 0 disabled.
Jun 6 02:06:17 kern warn kernel: W1B -2023690458
Jun 6 02:06:17 kern warn kernel: W1E -2023689779
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: Connection DOWN, LinkActiveStatus=0x0
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: ReconfigureSAR port 0 traffictype 0
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: SILI End - UtopiaCfg - 0
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: DS xDSL G.inp Mode = DISABLED
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: ATM Bonding configured in system. Fallback mode = Enabled
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: Bonding State is DATA_IDLE
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: SID MODE SET to 12 BIT MODE
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: ATM Bonding Mgmt Log Area = 89b7f514
Jun 6 02:06:20 daemon notice syslog: pppd:Terminating on signal 20.
Jun 6 02:06:20 daemon crit syslog: Clear IP addresses. PPP connection DOWN.
Jun 6 02:06:20 daemon crit syslog: Clear IP addresses. Connection DOWN.
Jun 6 02:06:33 kern crit kernel: Line 0: ADSL G.992 channel analysis
Jun 6 02:06:39 kern crit kernel: Line 0: ADSL link up, Bearer 0, us=921, ds=5561
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: SILI Start - UtopiaCfg - 0
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: AutoSenseATM is not enabled. Link Traffic type from PHY=1
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: XTM Link Information, port = 0, State = UP(1), Service Support = ATM(1)
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: ReconfigureSAR port 0 traffictype 1
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: SILI End - UtopiaCfg - 10
Jun 6 02:06:40 kern warn kernel: bcmxtmrt: TxPAF Status = Disabled
Jun 6 02:06:40 kern warn kernel: bcmxtmrt: MAC address: 60 03 47 4b 6b 9f
Jun 6 02:06:40 kern warn kernel: [DoCreateDeviceReq.775]: register_netdev
Jun 6 02:06:40 kern warn kernel: [DoCreateDeviceReq.777]: register_netdev done
Jun 6 02:06:40 kern warn kernel: [FAP0] xtmCreateDevice : devId 0, encapType 1, headerLen 0
Jun 6 02:06:40 kern warn kernel: Calling SetLinkInfo 2
Jun 6 02:06:40 kern warn kernel: bcmxtmcfg: Reserve TxQueueIdx=0 for vcid 0
Jun 6 02:06:40 kern warn kernel: NON-CO4 DSLAM based operations for PTM CRC & ENET FCS.
Jun 6 02:06:40 kern warn kernel: XTM Init: Ch:0 - 400 tx BDs at 0xa9a88000
Jun 6 02:06:40 kern warn kernel: bcmxtmcfg: Connection UP, LinkActiveStatus=0x1, US=921000, DS=5561000
Jun 6 02:06:40 kern warn kernel: [FAP1] xtmCreateDevice : devId 0, encapType 1, headerLen 0
Jun 6 02:06:40 kern warn kernel: [FAP0] xtmLinkUp : devId 0, matchId 0
Jun 6 02:06:40 kern warn kernel: [FAP1] xtmLinkUp : devId 0, matchId 0
Jun 6 02:06:41 daemon notice syslog: pppd:cms logging initialized.
Jun 6 02:06:41 daemon notice syslog: pppd:PPPoATM setdevname_pppoatm
Jun 6 02:06:41 daemon notice syslog: pppd:PPPoATM setdevname_pppoatm - SUCCESS
Jun 6 02:06:41 daemon notice syslog: pppd 2.4.1 started by admin, uid 0
Jun 6 02:06:41 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:06:41 kern warn kernel: netdev path : pppoa0
Jun 6 02:06:41 kern info kernel: -> atm0
Jun 6 02:06:41 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:06:41 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:06:50 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:06:50 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:06:53 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:06:53 kern warn kernel: netdev path : pppoa0
Jun 6 02:06:53 kern info kernel: ->
Jun 6 02:06:53 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:06:53 kern info kernel: atm0
Jun 6 02:06:53 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:02 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:07:02 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:07:05 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:07:05 kern warn kernel: netdev path : pppoa0 ->
Jun 6 02:07:05 kern info kernel: atm0
Jun 6 02:07:05 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:07:05 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:14 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:07:14 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:07:17 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:07:17 kern warn kernel: netdev path : pppoa0 ->
Jun 6 02:07:17 kern info kernel: atm0
Jun 6 02:07:17 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:07:17 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:26 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:07:26 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:07:29 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:07:29 kern warn kernel: netdev path :
Jun 6 02:07:29 kern info kernel: pppoa0 -> atm0
Jun 6 02:07:29 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:07:29 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:35 daemon err syslog: lcp up mtu=1500
Jun 6 02:07:35 daemon err syslog: lcp up ho->neg_mru=1500
Jun 6 02:07:35 daemon crit syslog: PPP LCP UP.
Jun 6 02:07:35 daemon notice syslog: pppd:Remote message: CHAP authentication success
Jun 6 02:07:35 daemon notice syslog: pppd:local IP address [[My public IP address here]]
Jun 6 02:07:35 daemon notice syslog: pppd:remote IP address 2.127.238.76
Jun 6 02:07:35 daemon notice syslog: pppd:primary DNS address 90.207.238.97
Jun 6 02:07:35 daemon notice syslog: pppd:secondary DNS address 90.207.238.99
Jun 6 02:07:35 daemon crit syslog: Received valid IP address from server. Connection UP.

billion_fan
Posts: 5272
Joined: Tue Jul 19, 2011 4:30 pm

Re: Internet dropping out at 2am each morning

Post by billion_fan » Tue Jun 09, 2020 12:13 pm

kevftw wrote:
Sat Jun 06, 2020 2:20 am
Hi all,

This might be something entirely ISP side so I'll be enquiring with them as well, but I was hoping someone might be able to glance over the logs below from my router when the connection is dropping out and see if there's anything relevant that might be to do with the router or my setup.

The problem as in the title, is basically between 02:00 and 02:06 so far, almost every day, the internet will drop out for 2-3 mins and then continue as normal. Not the end of the world obviously but if I'm still online at that time or downloading something it's a pain.

I've tried updating the firmware to 2.52.d41 which included the reset with factory defaults option but doesn't seem to have made any difference.


Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: SILI Start - UtopiaCfg - 10
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: AutoSenseATM is not enabled. Link Traffic type from PHY=1
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: XTM Link Information, port = 0, State = DOWN(2), Service Support = ATM(1)
Jun 6 02:06:17 kern warn kernel: Calling SetLinkInfo 1
Jun 6 02:06:17 kern warn kernel: HOST XTM tx ch 0 disabled.
Jun 6 02:06:17 kern warn kernel: W1B -2023690458
Jun 6 02:06:17 kern warn kernel: W1E -2023689779
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: Connection DOWN, LinkActiveStatus=0x0
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: ReconfigureSAR port 0 traffictype 0
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: SILI End - UtopiaCfg - 0
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: DS xDSL G.inp Mode = DISABLED
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: ATM Bonding configured in system. Fallback mode = Enabled
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: Bonding State is DATA_IDLE
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: SID MODE SET to 12 BIT MODE
Jun 6 02:06:17 kern warn kernel: bcmxtmcfg: ATM Bonding Mgmt Log Area = 89b7f514
Jun 6 02:06:20 daemon notice syslog: pppd:Terminating on signal 20.
Jun 6 02:06:20 daemon crit syslog: Clear IP addresses. PPP connection DOWN.
Jun 6 02:06:20 daemon crit syslog: Clear IP addresses. Connection DOWN.
Jun 6 02:06:33 kern crit kernel: Line 0: ADSL G.992 channel analysis
Jun 6 02:06:39 kern crit kernel: Line 0: ADSL link up, Bearer 0, us=921, ds=5561
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: SILI Start - UtopiaCfg - 0
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: AutoSenseATM is not enabled. Link Traffic type from PHY=1
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: XTM Link Information, port = 0, State = UP(1), Service Support = ATM(1)
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: ReconfigureSAR port 0 traffictype 1
Jun 6 02:06:39 kern warn kernel: bcmxtmcfg: SILI End - UtopiaCfg - 10
Jun 6 02:06:40 kern warn kernel: bcmxtmrt: TxPAF Status = Disabled
Jun 6 02:06:40 kern warn kernel: bcmxtmrt: MAC address: 60 03 47 4b 6b 9f
Jun 6 02:06:40 kern warn kernel: [DoCreateDeviceReq.775]: register_netdev
Jun 6 02:06:40 kern warn kernel: [DoCreateDeviceReq.777]: register_netdev done
Jun 6 02:06:40 kern warn kernel: [FAP0] xtmCreateDevice : devId 0, encapType 1, headerLen 0
Jun 6 02:06:40 kern warn kernel: Calling SetLinkInfo 2
Jun 6 02:06:40 kern warn kernel: bcmxtmcfg: Reserve TxQueueIdx=0 for vcid 0
Jun 6 02:06:40 kern warn kernel: NON-CO4 DSLAM based operations for PTM CRC & ENET FCS.
Jun 6 02:06:40 kern warn kernel: XTM Init: Ch:0 - 400 tx BDs at 0xa9a88000
Jun 6 02:06:40 kern warn kernel: bcmxtmcfg: Connection UP, LinkActiveStatus=0x1, US=921000, DS=5561000
Jun 6 02:06:40 kern warn kernel: [FAP1] xtmCreateDevice : devId 0, encapType 1, headerLen 0
Jun 6 02:06:40 kern warn kernel: [FAP0] xtmLinkUp : devId 0, matchId 0
Jun 6 02:06:40 kern warn kernel: [FAP1] xtmLinkUp : devId 0, matchId 0
Jun 6 02:06:41 daemon notice syslog: pppd:cms logging initialized.
Jun 6 02:06:41 daemon notice syslog: pppd:PPPoATM setdevname_pppoatm
Jun 6 02:06:41 daemon notice syslog: pppd:PPPoATM setdevname_pppoatm - SUCCESS
Jun 6 02:06:41 daemon notice syslog: pppd 2.4.1 started by admin, uid 0
Jun 6 02:06:41 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:06:41 kern warn kernel: netdev path : pppoa0
Jun 6 02:06:41 kern info kernel: -> atm0
Jun 6 02:06:41 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:06:41 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:06:50 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:06:50 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:06:53 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:06:53 kern warn kernel: netdev path : pppoa0
Jun 6 02:06:53 kern info kernel: ->
Jun 6 02:06:53 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:06:53 kern info kernel: atm0
Jun 6 02:06:53 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:02 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:07:02 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:07:05 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:07:05 kern warn kernel: netdev path : pppoa0 ->
Jun 6 02:07:05 kern info kernel: atm0
Jun 6 02:07:05 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:07:05 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:14 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:07:14 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:07:17 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:07:17 kern warn kernel: netdev path : pppoa0 ->
Jun 6 02:07:17 kern info kernel: atm0
Jun 6 02:07:17 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:07:17 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:26 daemon notice syslog: pppd:LCP: timeout sending Config-Requests
Jun 6 02:07:26 daemon notice syslog: pppd:Connection terminated.
Jun 6 02:07:29 daemon notice syslog: PPP: Start to connect ...
Jun 6 02:07:29 kern warn kernel: netdev path :
Jun 6 02:07:29 kern info kernel: pppoa0 -> atm0
Jun 6 02:07:29 daemon notice syslog: pppd:Using interface pppoa0
Jun 6 02:07:29 daemon notice syslog: pppd:Connect: pppoa0 <-->
Jun 6 02:07:35 daemon err syslog: lcp up mtu=1500
Jun 6 02:07:35 daemon err syslog: lcp up ho->neg_mru=1500
Jun 6 02:07:35 daemon crit syslog: PPP LCP UP.
Jun 6 02:07:35 daemon notice syslog: pppd:Remote message: CHAP authentication success
Jun 6 02:07:35 daemon notice syslog: pppd:local IP address [[My public IP address here]]
Jun 6 02:07:35 daemon notice syslog: pppd:remote IP address 2.127.238.76
Jun 6 02:07:35 daemon notice syslog: pppd:primary DNS address 90.207.238.97
Jun 6 02:07:35 daemon notice syslog: pppd:secondary DNS address 90.207.238.99
Jun 6 02:07:35 daemon crit syslog: Received valid IP address from server. Connection UP.
Looks like your ISP might need to check into the LCP timing issue reported by the router, pppd:LCP: timeout sending Config-Requests, also from the logs the line lost sync, then when it attempts to reconnect it gets the pppd:LCP: timeout sending Config-Requests issue

Post Reply