Netgate Discussion Forum
    • Categories
    • Recent
    • Tags
    • Popular
    • Users
    • Search
    • Register
    • Login

    PPPoE Connection Unstable

    Scheduled Pinned Locked Moved General pfSense Questions
    2 Posts 2 Posters 566 Views
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • D
      DazzaBear
      last edited by

      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 FreeBSD

      Thanks guys

      1 Reply Last reply Reply Quote 0
      • stephenw10S
        stephenw10 Netgate Administrator
        last edited by

        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

        1 Reply Last reply Reply Quote 0
        • First post
          Last post
        Copyright 2025 Rubicon Communications LLC (Netgate). All rights reserved.