PPPoE Connection Unstable
-
Afternoon folks,
Im having a weird problem whereby my pppoe connection keeps dropping, it successfully connects but this is happpening randomly and i dont know why. Obviously during this time it causes me loss of internet.
Anyone have any suggestions as to whats goin on? Below is a copy of my PPP logs;Aug 3 19:40:26 ppp: [wan] 81.156.95.xxx -> 172.16.12.107
Aug 3 19:40:26 ppp: [wan] IPCP: LayerUp
Aug 3 19:40:26 ppp: [wan] IPCP: state change Ack-Sent --> Opened
Aug 3 19:40:26 ppp: [wan] IPADDR 81.156.95.214
Aug 3 19:40:26 ppp: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
Aug 3 19:40:26 ppp: [wan] IPADDR 81.156.95.214
Aug 3 19:40:26 ppp: [wan] IPCP: SendConfigReq #3
Aug 3 19:40:26 ppp: [wan] 81.156.95.214 is OK
Aug 3 19:40:26 ppp: [wan] IPADDR 81.156.95.214
Aug 3 19:40:26 ppp: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
Aug 3 19:40:26 ppp: [wan] IFACE: Rename interface ng0 to pppoe0
Aug 3 19:40:26 ppp: [wan] IFACE: Up event
Aug 3 19:40:26 ppp: [wan] 02e0:4cff:fe68:84cb -> 0ea4:02ff:fe2e:bc01
Aug 3 19:40:26 ppp: [wan] IPV6CP: LayerUp
Aug 3 19:40:26 ppp: [wan] IPV6CP: state change Ack-Sent --> Opened
Aug 3 19:40:26 ppp: [wan] IPV6CP: rec'd Configure Ack #1 (Ack-Sent)
Aug 3 19:40:26 ppp: [wan] IPADDR 0.0.0.0
Aug 3 19:40:26 ppp: [wan] IPCP: SendConfigReq #2
Aug 3 19:40:26 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug 3 19:40:26 ppp: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
Aug 3 19:40:26 ppp: [wan] IPCP: state change Req-Sent --> Ack-Sent
Aug 3 19:40:26 ppp: [wan] IPADDR 172.16.12.107
Aug 3 19:40:26 ppp: [wan] IPCP: SendConfigAck #57
Aug 3 19:40:26 ppp: [wan] 172.16.12.107 is OK
Aug 3 19:40:26 ppp: [wan] IPADDR 172.16.12.107
Aug 3 19:40:26 ppp: [wan] IPCP: rec'd Configure Request #57 (Req-Sent)
Aug 3 19:40:26 ppp: [wan] IPV6CP: state change Req-Sent --> Ack-Sent
Aug 3 19:40:26 ppp: [wan] IPV6CP: SendConfigAck #108
Aug 3 19:40:26 ppp: [wan] IPV6CP: rec'd Configure Request #108 (Req-Sent)
Aug 3 19:40:26 ppp: [wan] IPV6CP: SendConfigReq #1
Aug 3 19:40:26 ppp: [wan] IPV6CP: state change Starting --> Req-Sent
Aug 3 19:40:26 ppp: [wan] IPV6CP: Up event
Aug 3 19:40:26 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug 3 19:40:26 ppp: [wan] IPADDR 0.0.0.0
Aug 3 19:40:26 ppp: [wan] IPCP: SendConfigReq #1
Aug 3 19:40:26 ppp: [wan] IPCP: state change Starting --> Req-Sent
Aug 3 19:40:26 ppp: [wan] IPCP: Up event
Aug 3 19:40:26 ppp: [wan] IPV6CP: LayerStart
Aug 3 19:40:26 ppp: [wan] IPV6CP: state change Initial --> Starting
Aug 3 19:40:26 ppp: [wan] IPV6CP: Open event
Aug 3 19:40:26 ppp: [wan] IPCP: LayerStart
Aug 3 19:40:26 ppp: [wan] IPCP: state change Initial --> Starting
Aug 3 19:40:26 ppp: [wan] IPCP: Open event
Aug 3 19:40:26 ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
Aug 3 19:40:26 ppp: [wan_link0] Link: Join bundle "wan"
Aug 3 19:40:26 ppp: [wan_link0] Link: Matched action 'bundle "wan" ""'
Aug 3 19:40:26 ppp: [wan_link0] LCP: authorization successful
Aug 3 19:40:26 ppp: [wan_link0] MESG: CHAP authentication success
Aug 3 19:40:26 ppp: [wan_link0] CHAP: rec'd SUCCESS #1 len: 31
Aug 3 19:40:26 ppp: [wan_link0] CHAP: sending RESPONSE #1 len: 46
Aug 3 19:40:26 ppp: [wan_link0] CHAP: Using authname "bthomehub@btbroadband.com"
Aug 3 19:40:26 ppp: [wan_link0] Name: "acc-aln2.hac"
Aug 3 19:40:26 ppp: [wan_link0] CHAP: rec'd CHALLENGE #1 len: 62
Aug 3 19:40:26 ppp: [wan_link0] LCP: LayerUp
Aug 3 19:40:26 ppp: [wan_link0] LCP: auth: peer wants CHAP, I want nothing
Aug 3 19:40:26 ppp: [wan_link0] LCP: state change Ack-Sent --> Opened
Aug 3 19:40:26 ppp: [wan_link0] MAGICNUM 0x039adbc2
Aug 3 19:40:26 ppp: [wan_link0] MRU 1492
Aug 3 19:40:26 ppp: [wan_link0] LCP: rec'd Configure Ack #2 (Ack-Sent)
Aug 3 19:40:26 ppp: [wan_link0] MAGICNUM 0x039adbc2
Aug 3 19:40:26 ppp: [wan_link0] MRU 1492
Aug 3 19:40:26 ppp: [wan_link0] LCP: SendConfigReq #2
Aug 3 19:40:26 ppp: [wan_link0] PROTOCOMP
Aug 3 19:40:26 ppp: [wan_link0] LCP: rec'd Configure Reject #1 (Ack-Sent)
Aug 3 19:40:26 ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
Aug 3 19:40:26 ppp: [wan_link0] MAGICNUM 0x715fca98
Aug 3 19:40:26 ppp: [wan_link0] AUTHPROTO CHAP MD5
Aug 3 19:40:26 ppp: [wan_link0] MRU 1492
Aug 3 19:40:26 ppp: [wan_link0] LCP: SendConfigAck #255
Aug 3 19:40:26 ppp: [wan_link0] MAGICNUM 0x715fca98
Aug 3 19:40:26 ppp: [wan_link0] AUTHPROTO CHAP MD5
Aug 3 19:40:26 ppp: [wan_link0] MRU 1492
Aug 3 19:40:26 ppp: [wan_link0] LCP: rec'd Configure Request #255 (Req-Sent)
Aug 3 19:40:26 ppp: [wan_link0] MAGICNUM 0x039adbc2
Aug 3 19:40:26 ppp: [wan_link0] MRU 1492
Aug 3 19:40:26 ppp: [wan_link0] PROTOCOMP
Aug 3 19:40:26 ppp: [wan_link0] LCP: SendConfigReq #1
Aug 3 19:40:26 ppp: [wan_link0] LCP: state change Starting --> Req-Sent
Aug 3 19:40:26 ppp: [wan_link0] LCP: Up event
Aug 3 19:40:26 ppp: [wan_link0] Link: UP event
Aug 3 19:40:26 ppp: [wan_link0] PPPoE: connection successful
Aug 3 19:40:26 ppp: PPPoE: rec'd ACNAME "acc-aln2.hac"
Aug 3 19:40:26 ppp: [wan_link0] PPPoE: Connecting to ''
Aug 3 19:40:26 ppp: [wan_link0] LCP: LayerStart
Aug 3 19:40:26 ppp: [wan_link0] LCP: state change Initial --> Starting
Aug 3 19:40:26 ppp: [wan_link0] LCP: Open event
Aug 3 19:40:26 ppp: [wan_link0] Link: OPEN event
Aug 3 19:40:26 ppp: [wan] Bundle: Interface ng0 created
Aug 3 19:40:26 ppp: web: web is not running
Aug 3 19:40:26 ppp: process 88961 terminated
Aug 3 19:40:26 ppp: [wan_link0] Link: Shutdown
Aug 3 19:40:26 ppp: [wan] Bundle: Shutdown
Aug 3 19:40:25 ppp: waiting for process 88961 to die...
Aug 3 19:40:24 ppp: waiting for process 88961 to die...
Aug 3 19:40:24 ppp: [wan_link0] LCP: state change Closing --> Initial
Aug 3 19:40:24 ppp: [wan_link0] LCP: LayerFinish
Aug 3 19:40:24 ppp: [wan_link0] LCP: Down event
Aug 3 19:40:24 ppp: [wan_link0] LCP: state change Stopping --> Closing
Aug 3 19:40:24 ppp: [wan_link0] LCP: Close event
Aug 3 19:40:24 ppp: [wan_link0] Link: giving up after 0 reconnection attempts
Aug 3 19:40:24 ppp: [wan_link0] Link: DOWN event
Aug 3 19:40:24 ppp: [wan_link0] PPPoE: connection closed
Aug 3 19:40:24 ppp: [wan] rec'd unexpected protocol IP
Aug 3 19:40:24 ppp: [wan] rec'd unexpected protocol IP
Aug 3 19:40:24 ppp: [wan] rec'd unexpected protocol IP
Aug 3 19:40:24 ppp: [wan] rec'd unexpected protocol IP
Aug 3 19:40:24 ppp: [wan_link0] LCP: LayerDown
Aug 3 19:40:24 ppp: [wan_link0] LCP: SendTerminateAck #3
Aug 3 19:40:24 ppp: [wan] IPV6CP: state change Closing --> Initial
Aug 3 19:40:24 ppp: [wan] Bundle: No NCPs left. Closing links...
Aug 3 19:40:24 ppp: [wan] IPV6CP: LayerFinish
Aug 3 19:40:24 ppp: [wan] IPV6CP: Down event
Aug 3 19:40:24 ppp: [wan] IPCP: state change Closed --> Initial
Aug 3 19:40:24 ppp: [wan] IPCP: Down event
Aug 3 19:40:24 ppp: [wan] IPV6CP: Close event
Aug 3 19:40:24 ppp: [wan] IPCP: Close event
Aug 3 19:40:24 ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Aug 3 19:40:24 ppp: [wan_link0] Link: Leave bundle "wan"
Aug 3 19:40:24 ppp: [wan_link0] LCP: state change Opened --> Stopping
Aug 3 19:40:24 ppp: [wan_link0] LCP: rec'd Terminate Request #121 (Opened)
Aug 3 19:40:24 ppp: [wan] IPCP: LayerFinish
Aug 3 19:40:24 ppp: [wan] IPCP: state change Closing --> Closed
Aug 3 19:40:24 ppp: [wan] IPCP: rec'd Terminate Ack #4 (Closing)
Aug 3 19:40:24 ppp: [wan] IFACE: Rename interface pppoe0 to pppoe0
Aug 3 19:40:24 ppp: [wan] IFACE: Down event
Aug 3 19:40:23 ppp: [wan] IPV6CP: LayerDown
Aug 3 19:40:23 ppp: [wan] IPV6CP: SendTerminateReq #2
Aug 3 19:40:23 ppp: [wan] IPV6CP: state change Opened --> Closing
Aug 3 19:40:23 ppp: [wan] IPV6CP: Close event
Aug 3 19:40:23 ppp: [wan] IFACE: Removing IPv4 address from pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Can't assign requested address
Aug 3 19:40:23 ppp: [wan] IPCP: LayerDown
Aug 3 19:40:23 ppp: [wan] IPCP: SendTerminateReq #4
Aug 3 19:40:23 ppp: [wan] IPCP: state change Opened --> Closing
Aug 3 19:40:23 ppp: [wan] IPCP: Close event
Aug 3 19:40:23 ppp: [wan] IFACE: Close event
Aug 3 19:40:23 ppp: caught fatal signal TERM
Aug 3 19:40:23 ppp: waiting for process 88961 to die...
Aug 3 19:40:23 ppp: process 10649 started, version 5.8 (root@pfSense_v2_4_4_amd64-pfSense_v2_4_4-job-09 11:56 16-Nov-2018)
Aug 3 19:40:23 ppp:
Aug 3 19:40:23 ppp: Multi-link PPP daemon for FreeBSDThanks guys
-
There doesn't appear to be anything wrong shown in those logs. If the daemon should not have been restarted at that point I would check the system logs for that point to see what was happening that may have restarted it.
Steve
