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

    PPPoE WAN fails to reconnect after link loss

    Scheduled Pinned Locked Moved General pfSense Questions
    60 Posts 7 Posters 12.7k 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.
    • V
      vegbrasil @Joxxxx
      last edited by

      @joxxxx I have yet to find a solution. For me, the (re)connection works fine on other OSes and devices as well.

      Let me know you find out anything. Unfortunately I'm considering migrating to something else.

      J 1 Reply Last reply Reply Quote 1
      • J
        Joxxxx @vegbrasil
        last edited by

        @vegbrasil After countless hours, I found out that the pppoe layer of pfsense 2.4.4 is bugged ! Something changed and because of that, the connection cannot be made with the above errors. Tried it also on a clean 2.4.4 install.

        Re-installed 2.4.3 and all works again without any problems ! The thing is that I cannot install any packages anymore because it wants me to update to 2.4.4...

        Btw, tried the dev 2.4.5 version and the bug is still the same.

        I hope this will be fixed because it mus affect a lot of people...

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

          Hmm, there must be something different about your connection. I have two WANs here, both are PPPoE. The only issue I saw was when the ISP(s) had an outage. However the logs showed it as very broken, nothing like what you're seeing.
          If PPPoE was broken in general there would be hundreds of posts about it by now.

          Are you able to try a different NIC type?

          Steve

          V 1 Reply Last reply Reply Quote 0
          • V
            vegbrasil @stephenw10
            last edited by vegbrasil

            @stephenw10 I've been using pfSense with the same FTTH PPPoE connection and two different NICs models:

            • Realtek NICs (re): crazy bugs, completely unusable - expected, I guess;
            • Intel PRO/1000 NICs (em): Problem of the initial post: first connection is fine, re-connection never happens. If we forget this problem, everything is working great and I can max-out the connection (150 Mbps).

            Upgraded and tried clean install between 2.3.5 and all 2.4.x versions.

            Thanks!

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

              Hmm, yes, this seems like it must be some other issue since you were seeing it in 2.4.3 also.

              Steve

              J 1 Reply Last reply Reply Quote 0
              • J
                Joxxxx
                last edited by

                I'm using a quad ethernet intel pro and never got any problems since v 2.0 or something like that on vmware and the vmx3 driver.

                After analysing a bit the problem, could it be that I have this problem because pfsense sees his local ip address as the FTTH gateway ?
                Maybe something changed in pf 2.4.4 in the pppoe connection that forbids the use of it ? (This could explain the two errors I get).

                V 1 Reply Last reply Reply Quote 0
                • V
                  vegbrasil @Joxxxx
                  last edited by

                  @joxxxx said in PPPoE WAN fails to reconnect after link loss:

                  I'm using a quad ethernet intel pro

                  I'm using the exactly same hardware and since we're having the same problem, we may have found the initial cause.

                  1 Reply Last reply Reply Quote 0
                  • J
                    Joxxxx @stephenw10
                    last edited by

                    @stephenw10 On my side, 2.4.3 is working perfectly and reaching the 1Gbits of the fiber connection. The problem is 2.4.4 and above where it doesn't want to allocate the ip address it gets (I can see the received ip address in the logs, but the error prevents it to be used).

                    1 Reply Last reply Reply Quote 0
                    • T
                      timboau 0
                      last edited by

                      How did you get anywhere with this problem?

                      I'm experiencing the same issue:

                      Could it be the PPPoE is not receiving a gateway address and the IP address its been given is a /32 255.255.255.255 address

                      This is the case with mine.

                      I started on 2.4.3 upgraded to 2.4.4 (this causes the WAN to drop and it attempt another connection - 2.4.3 got this error and left the link up)

                      Feb 4 12:22:20 ppp [wan] IFACE: Adding IPv4 address to pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Destination address required
                      Feb 4 12:22:20 ppp [wan] 118.xxx.xxx.xxx -> 0.0.0.0
                      Feb 4 12:22:20 ppp [wan] IPCP: LayerUp
                      Feb 4 12:22:20 ppp [wan] IPCP: state change Ack-Sent --> Opened
                      Feb 4 12:22:20 ppp [wan] IPADDR 118.xxx.xxx.xxx

                      V 1 Reply Last reply Reply Quote 0
                      • V
                        vegbrasil @timboau 0
                        last edited by

                        @timboau-0 I still have the issue, running the latest stable version of pfSense.

                        This weekend I needed to visit a site that was offline due this reconnection problem. I'm thinking of making some sort of simple script to reboot the server if the WAN is offline for a few minutes...

                        Thanks!

                        T 1 Reply Last reply Reply Quote 0
                        • T
                          timboau 0 @vegbrasil
                          last edited by

                          This post is deleted!
                          1 Reply Last reply Reply Quote 0
                          • T
                            timboau 0
                            last edited by

                            I'll add that im using APU intel nic no VM
                            Tested clean install of 2.3.1 & 2.4.4

                            2.3.1 has some additional information:
                            Feb 4 02:35:58 ppp [wan] IPCP: LayerUp
                            Feb 4 02:35:58 ppp [wan] 118.xxx.xxx.xxx -> 0.0.0.0
                            Feb 4 02:35:58 ppp [wan] IFACE: Adding IPv4 address to pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Destination address required
                            Feb 4 02:35:58 check_reload_status Rewriting resolv.conf
                            Feb 4 02:35:58 php-fpm 19680 /rc.interfaces_wan_configure: Accept router advertisements on interface igb0
                            Feb 4 02:35:59 check_reload_status updating dyndns wan
                            Feb 4 02:35:59 check_reload_status rc.newwanip starting pppoe0
                            Feb 4 02:35:59 ppp [wan] IFACE: Up event
                            Feb 4 02:35:59 ppp [wan] IFACE: Rename interface ng0 to pppoe0
                            Feb 4 02:36:00 php-fpm 34057 /rc.newwanip: rc.newwanip: Info: starting on pppoe0.
                            Feb 4 02:36:00 php-fpm 34057 /rc.newwanip: rc.newwanip: on (IP address: ) (interface: WAN[wan]) (real interface: pppoe0).
                            Feb 4 02:36:00 php-fpm 34057 /rc.newwanip: rc.newwanip: Failed to update wan IP, restarting...
                            Feb 4 02:36:00 check_reload_status Configuring interface wan
                            Feb 4 02:36:01 check_reload_status Reloading filter
                            Feb 4 02:36:01 php-fpm 16228 /interfaces.php: Creating rrd update script
                            Feb 4 02:36:02 xinetd 9811 Starting reconfiguration
                            Feb 4 02:36:02 xinetd 9811 Swapping defaults
                            Feb 4 02:36:02 xinetd 9811 readjusting service 6969-udp
                            Feb 4 02:36:02 xinetd 9811 Reconfigured: new=0 old=1 dropped=0 (services)
                            Feb 4 02:36:05 php-fpm 23933 /rc.interfaces_wan_configure: Accept router advertisements on interface igb0

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

                              /32 is valid for a PPP connection as is a gateway outside the subnet.

                              Obviously no gateway at all isn't though.

                              Steve

                              1 Reply Last reply Reply Quote 0
                              • T
                                timboau 0
                                last edited by timboau 0

                                I got my config working on 2.4.3 (but I think it will break on 2.4.4) - I had a slightly different problem to the above.

                                With 2.4.3 I can authenticate and the interface stays up
                                2.4.4 I authenticate and the interface cant be configured as it doesnt have a gateway IP so it goes down and then re-connects. (repeat)

                                I fixed my problem : (Not being supplied a gateway via PPPoE)
                                Configuring the interface with PPPoE (as per usual)
                                Then creating a NEW interface on the same port as STATIC (save)
                                Then open the interface again and create a gateway using that same IP

                                I can see that if I lost authentication now on 2.4.3 I would likely loose connectivity as the PPPoE wont try again (without a reboot or port cycle)
                                I worry on 2.4.4 that it will fail the interface configuration due to the missing gateway then the 2nd interface wont work either..

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

                                  Hmm, try it and see. Odd setup.

                                  Steve

                                  1 Reply Last reply Reply Quote 0
                                  • 1
                                    1eyebrow @timboau 0
                                    last edited by 1eyebrow

                                    @timboau-0
                                    Did someone noticed the same File Exists! error for PPPoE on 2.5.2 ? I have the same issue after the upgrade.

                                    IFACE: Adding IPv4 address to pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): File exists

                                    1 Reply Last reply Reply Quote 0
                                    • S
                                      saswatasarkar13
                                      last edited by

                                      I am also facing the same problem on 2.5.2 version. Pls Help

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

                                        Which problem exactly are you seeing? PPPoE connection with no gateway? Can we see some logs?

                                        Steve

                                        S 1 Reply Last reply Reply Quote 0
                                        • S
                                          saswatasarkar13 @stephenw10
                                          last edited by

                                          @stephenw10 Yes sir, Sorry I am late. This is the PPP log. See first it was connected and then I disconnected the cable to pfsense to simulate a disconnection and it does not connect again. I had to reboot the box to get connected again. Thanks for helping.

                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MAGICNUM 0x754938a9
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: state change Req-Sent --> Ack-Sent
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: rec'd Configure Reject #1 (Ack-Sent)
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] PROTOCOMP
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: SendConfigReq #2
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MRU 1492
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MAGICNUM 0x745b8af8
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: rec'd Configure Nak #2 (Ack-Sent)
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MRU 1460
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: SendConfigReq #3
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MRU 1460
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MAGICNUM 0x745b8af8
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent)
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MRU 1460
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MAGICNUM 0x745b8af8
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: state change Ack-Sent --> Opened
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: auth: peer wants CHAP, I want nothing
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: LayerUp
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] CHAP: rec'd CHALLENGE #1 len: 39
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] Name: "XXXXXXXXXXXX"
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] CHAP: Using authname "XXXXXXXX"
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] CHAP: sending RESPONSE #1 len: 50
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] CHAP: rec'd SUCCESS #1 len: 26
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] MESG: Authentication Success
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] LCP: authorization successful
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] Link: Matched action 'bundle "wan" ""'
                                          Dec 6 20:16:26 ppp 89924 [wan_link0] Link: Join bundle "wan"
                                          Dec 6 20:16:26 ppp 89924 [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: Open event
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: state change Initial --> Starting
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: LayerStart
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: Up event
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: state change Starting --> Req-Sent
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: SendConfigReq #1
                                          Dec 6 20:16:26 ppp 89924 [wan] IPADDR 0.0.0.0
                                          Dec 6 20:16:26 ppp 89924 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
                                          Dec 6 20:16:26 ppp 89924 [wan] PRIDNS 0.0.0.0
                                          Dec 6 20:16:26 ppp 89924 [wan] SECDNS 0.0.0.0
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: rec'd Configure Request #187 (Req-Sent)
                                          Dec 6 20:16:26 ppp 89924 [wan] IPADDR IP.ADDRESS..1
                                          Dec 6 20:16:26 ppp 89924 [wan] IP.ADDRESS..1 is OK
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: SendConfigAck #187
                                          Dec 6 20:16:26 ppp 89924 [wan] IPADDR IP.ADDRESS..1
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: state change Req-Sent --> Ack-Sent
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
                                          Dec 6 20:16:26 ppp 89924 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: SendConfigReq #2
                                          Dec 6 20:16:26 ppp 89924 [wan] IPADDR 0.0.0.0
                                          Dec 6 20:16:26 ppp 89924 [wan] PRIDNS 0.0.0.0
                                          Dec 6 20:16:26 ppp 89924 [wan] SECDNS 0.0.0.0
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
                                          Dec 6 20:16:26 ppp 89924 [wan] IPADDR IP.ADDRESS..3
                                          Dec 6 20:16:26 ppp 89924 [wan] IP.ADDRESS..3 is OK
                                          Dec 6 20:16:26 ppp 89924 [wan] PRIDNS IP.ADDRESS..193
                                          Dec 6 20:16:26 ppp 89924 [wan] SECDNS IP.ADDRESS..225
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: SendConfigReq #3
                                          Dec 6 20:16:26 ppp 89924 [wan] IPADDR IP.ADDRESS..3
                                          Dec 6 20:16:26 ppp 89924 [wan] PRIDNS IP.ADDRESS..193
                                          Dec 6 20:16:26 ppp 89924 [wan] SECDNS IP.ADDRESS..225
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
                                          Dec 6 20:16:26 ppp 89924 [wan] IPADDR IP.ADDRESS..3
                                          Dec 6 20:16:26 ppp 89924 [wan] PRIDNS IP.ADDRESS..193
                                          Dec 6 20:16:26 ppp 89924 [wan] SECDNS IP.ADDRESS..225
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: state change Ack-Sent --> Opened
                                          Dec 6 20:16:26 ppp 89924 [wan] IPCP: LayerUp
                                          Dec 6 20:16:26 ppp 89924 [wan] IP.ADDRESS..3 -> IP.ADDRESS..1
                                          Dec 6 20:16:27 ppp 89924 [wan] IFACE: Up event
                                          Dec 6 20:16:27 ppp 89924 [wan] IFACE: Rename interface ng0 to pppoe0
                                          Dec 7 01:55:41 ppp 7531 Multi-link PPP daemon for FreeBSD
                                          Dec 7 01:55:41 ppp 7531 process 7531 started, version 5.9
                                          Dec 7 01:55:41 ppp 7531 web: web is not running
                                          Dec 7 01:55:41 ppp 7531 [wan] Bundle: Interface ng0 created
                                          Dec 7 01:55:41 ppp 7531 [wan_link0] Link: OPEN event
                                          Dec 7 01:55:41 ppp 7531 [wan_link0] LCP: Open event
                                          Dec 7 01:55:41 ppp 7531 [wan_link0] LCP: state change Initial --> Starting
                                          Dec 7 01:55:41 ppp 7531 [wan_link0] LCP: LayerStart
                                          Dec 7 01:55:41 ppp 7531 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 01:55:44 ppp 7531 PPPoE: rec'd ACNAME "XXXXXXXXXXXXXXXXXXX"
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] PPPoE: connection successful
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] Link: UP event
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: Up event
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: state change Starting --> Req-Sent
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: SendConfigReq #1
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] PROTOCOMP
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MRU 1492
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MAGICNUM 0x42de2289
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: rec'd Configure Request #244 (Req-Sent)
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MRU 1460
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] AUTHPROTO CHAP MD5
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MAGICNUM 0x22726716
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: SendConfigAck #244
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MRU 1460
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] AUTHPROTO CHAP MD5
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MAGICNUM 0x22726716
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: state change Req-Sent --> Ack-Sent
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: rec'd Configure Reject #1 (Ack-Sent)
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] PROTOCOMP
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: SendConfigReq #2
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MRU 1492
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MAGICNUM 0x42de2289
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: rec'd Configure Nak #2 (Ack-Sent)
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MRU 1460
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: SendConfigReq #3
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MRU 1460
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MAGICNUM 0x42de2289
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent)
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MRU 1460
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] MAGICNUM 0x42de2289
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: state change Ack-Sent --> Opened
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: auth: peer wants CHAP, I want nothing
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] LCP: LayerUp
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] CHAP: rec'd CHALLENGE #1 len: 39
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] Name: "XXXXXXXXXXX"
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] CHAP: Using authname "XXXXXXXX"
                                          Dec 7 01:55:44 ppp 7531 [wan_link0] CHAP: sending RESPONSE #1 len: 50
                                          Dec 7 01:55:45 ppp 7531 [wan_link0] CHAP: rec'd SUCCESS #1 len: 26
                                          Dec 7 01:55:45 ppp 7531 [wan_link0] MESG: Authentication Success
                                          Dec 7 01:55:45 ppp 7531 [wan_link0] LCP: authorization successful
                                          Dec 7 01:55:45 ppp 7531 [wan_link0] Link: Matched action 'bundle "wan" ""'
                                          Dec 7 01:55:45 ppp 7531 [wan_link0] Link: Join bundle "wan"
                                          Dec 7 01:55:45 ppp 7531 [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: Open event
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: state change Initial --> Starting
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: LayerStart
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: Up event
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: state change Starting --> Req-Sent
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: SendConfigReq #1
                                          Dec 7 01:55:45 ppp 7531 [wan] IPADDR 0.0.0.0
                                          Dec 7 01:55:45 ppp 7531 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: rec'd Configure Request #228 (Req-Sent)
                                          Dec 7 01:55:45 ppp 7531 [wan] IPADDR IP.ADDRESS..1
                                          Dec 7 01:55:45 ppp 7531 [wan] IP.ADDRESS..1 is OK
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: SendConfigAck #228
                                          Dec 7 01:55:45 ppp 7531 [wan] IPADDR IP.ADDRESS..1
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: state change Req-Sent --> Ack-Sent
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
                                          Dec 7 01:55:45 ppp 7531 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: SendConfigReq #2
                                          Dec 7 01:55:45 ppp 7531 [wan] IPADDR 0.0.0.0
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
                                          Dec 7 01:55:45 ppp 7531 [wan] IPADDR IP.ADDRESS..3
                                          Dec 7 01:55:45 ppp 7531 [wan] IP.ADDRESS..3 is OK
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: SendConfigReq #3
                                          Dec 7 01:55:45 ppp 7531 [wan] IPADDR IP.ADDRESS..3
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
                                          Dec 7 01:55:45 ppp 7531 [wan] IPADDR IP.ADDRESS..3
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: state change Ack-Sent --> Opened
                                          Dec 7 01:55:45 ppp 7531 [wan] IPCP: LayerUp
                                          Dec 7 01:55:45 ppp 7531 [wan] IP.ADDRESS..3 -> IP.ADDRESS..1
                                          Dec 7 01:55:45 ppp 7531 [wan] IFACE: Up event
                                          Dec 7 01:55:45 ppp 7531 [wan] IFACE: Rename interface ng0 to pppoe0
                                          Dec 7 02:02:04 ppp 56916 Multi-link PPP daemon for FreeBSD
                                          Dec 7 02:02:04 ppp 56916 process 56916 started, version 5.9
                                          Dec 7 02:02:04 ppp 7531 caught fatal signal TERM
                                          Dec 7 02:02:04 ppp 7531 [wan] IFACE: Close event
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: Close event
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: state change Opened --> Closing
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: SendTerminateReq #4
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: LayerDown
                                          Dec 7 02:02:04 ppp 56916 waiting for process 7531 to die...
                                          Dec 7 02:02:04 ppp 7531 [wan] IFACE: Removing IPv4 address from pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Can't assign requested address
                                          Dec 7 02:02:04 ppp 7531 [wan] IFACE: Down event
                                          Dec 7 02:02:04 ppp 7531 [wan] IFACE: Rename interface pppoe0 to pppoe0
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: rec'd Terminate Ack #4 (Closing)
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: state change Closing --> Closed
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: LayerFinish
                                          Dec 7 02:02:04 ppp 7531 [wan] Bundle: No NCPs left. Closing links...
                                          Dec 7 02:02:04 ppp 7531 [wan] Bundle: closing link "wan_link0"...
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] LCP: rec'd Terminate Request #245 (Opened)
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] LCP: state change Opened --> Stopping
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] Link: Leave bundle "wan"
                                          Dec 7 02:02:04 ppp 7531 [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: Close event
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: Down event
                                          Dec 7 02:02:04 ppp 7531 [wan] IPCP: state change Closed --> Initial
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] LCP: SendTerminateAck #4
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] LCP: LayerDown
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] Link: CLOSE event
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] LCP: Close event
                                          Dec 7 02:02:04 ppp 7531 [wan_link0] LCP: state change Stopping --> Closing
                                          Dec 7 02:02:05 ppp 56916 waiting for process 7531 to die...
                                          Dec 7 02:02:06 ppp 56916 waiting for process 7531 to die...
                                          Dec 7 02:02:06 ppp 7531 [wan_link0] LCP: state change Closing --> Closed
                                          Dec 7 02:02:06 ppp 7531 [wan_link0] LCP: LayerFinish
                                          Dec 7 02:02:06 ppp 7531 [wan] Bundle: Shutdown
                                          Dec 7 02:02:07 ppp 7531 [wan_link0] Link: Shutdown
                                          Dec 7 02:02:07 ppp 7531 process 7531 terminated
                                          Dec 7 02:02:08 ppp 56916 web: web is not running
                                          Dec 7 02:02:08 ppp 56916 [wan] Bundle: Interface ng0 created
                                          Dec 7 02:02:08 ppp 56916 [wan_link0] Link: OPEN event
                                          Dec 7 02:02:08 ppp 56916 [wan_link0] LCP: Open event
                                          Dec 7 02:02:08 ppp 56916 [wan_link0] LCP: state change Initial --> Starting
                                          Dec 7 02:02:08 ppp 56916 [wan_link0] LCP: LayerStart
                                          Dec 7 02:02:08 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:02:17 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:02:17 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:02:17 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:02:17 ppp 56916 [wan_link0] Link: reconnection attempt 1 in 1 seconds
                                          Dec 7 02:02:18 ppp 56916 [wan_link0] Link: reconnection attempt 1
                                          Dec 7 02:02:18 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:02:27 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:02:27 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:02:27 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:02:27 ppp 56916 [wan_link0] Link: reconnection attempt 2 in 1 seconds
                                          Dec 7 02:02:28 ppp 56916 [wan_link0] Link: reconnection attempt 2
                                          Dec 7 02:02:28 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:02:37 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:02:37 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:02:37 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:02:37 ppp 56916 [wan_link0] Link: reconnection attempt 3 in 2 seconds
                                          Dec 7 02:02:39 ppp 56916 [wan_link0] Link: reconnection attempt 3
                                          Dec 7 02:02:39 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:02:48 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:02:48 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:02:48 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:02:48 ppp 56916 [wan_link0] Link: reconnection attempt 4 in 3 seconds
                                          Dec 7 02:02:51 ppp 56916 [wan_link0] Link: reconnection attempt 4
                                          Dec 7 02:02:51 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:03:00 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:03:00 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:03:00 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:03:00 ppp 56916 [wan_link0] Link: reconnection attempt 5 in 3 seconds
                                          Dec 7 02:03:03 ppp 56916 [wan_link0] Link: reconnection attempt 5
                                          Dec 7 02:03:03 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:03:12 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:03:12 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:03:12 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:03:12 ppp 56916 [wan_link0] Link: reconnection attempt 6 in 3 seconds
                                          Dec 7 02:03:15 ppp 56916 [wan_link0] Link: reconnection attempt 6
                                          Dec 7 02:03:15 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:03:24 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:03:24 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:03:24 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:03:24 ppp 56916 [wan_link0] Link: reconnection attempt 7 in 2 seconds
                                          Dec 7 02:03:26 ppp 56916 [wan_link0] Link: reconnection attempt 7
                                          Dec 7 02:03:26 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:03:35 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:03:35 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:03:35 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:03:35 ppp 56916 [wan_link0] Link: reconnection attempt 8 in 2 seconds
                                          Dec 7 02:03:37 ppp 56916 [wan_link0] Link: reconnection attempt 8
                                          Dec 7 02:03:37 ppp 56916 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:03:46 ppp 56916 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:03:46 ppp 56916 [wan_link0] Link: DOWN event
                                          Dec 7 02:03:46 ppp 56916 [wan_link0] LCP: Down event
                                          Dec 7 02:03:46 ppp 56916 [wan_link0] Link: reconnection attempt 9 in 4 seconds
                                          Dec 7 02:03:48 ppp 42670 Multi-link PPP daemon for FreeBSD
                                          Dec 7 02:03:48 ppp 42670 process 42670 started, version 5.9
                                          Dec 7 02:03:48 ppp 42670 waiting for process 56916 to die...
                                          Dec 7 02:03:48 ppp 56916 caught fatal signal TERM
                                          Dec 7 02:03:48 ppp 56916 [wan] IFACE: Close event
                                          Dec 7 02:03:48 ppp 56916 [wan] IPCP: Close event
                                          Dec 7 02:03:49 ppp 42670 waiting for process 56916 to die...
                                          Dec 7 02:03:50 ppp 56916 [wan_link0] LCP: Close event
                                          Dec 7 02:03:50 ppp 56916 [wan_link0] LCP: state change Starting --> Initial
                                          Dec 7 02:03:50 ppp 56916 [wan_link0] LCP: LayerFinish
                                          Dec 7 02:03:50 ppp 56916 [wan] Bundle: Shutdown
                                          Dec 7 02:03:50 ppp 42670 waiting for process 56916 to die...
                                          Dec 7 02:03:50 ppp 56916 [wan_link0] Link: Shutdown
                                          Dec 7 02:03:50 ppp 56916 process 56916 terminated
                                          Dec 7 02:03:51 ppp 42670 web: web is not running
                                          Dec 7 02:03:51 ppp 42670 [wan] Bundle: Interface ng0 created
                                          Dec 7 02:03:51 ppp 42670 [wan_link0] Link: OPEN event
                                          Dec 7 02:03:51 ppp 42670 [wan_link0] LCP: Open event
                                          Dec 7 02:03:51 ppp 42670 [wan_link0] LCP: state change Initial --> Starting
                                          Dec 7 02:03:51 ppp 42670 [wan_link0] LCP: LayerStart
                                          Dec 7 02:03:51 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:04:00 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:04:00 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:04:00 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:04:00 ppp 42670 [wan_link0] Link: reconnection attempt 1 in 3 seconds
                                          Dec 7 02:04:03 ppp 42670 [wan_link0] Link: reconnection attempt 1
                                          Dec 7 02:04:03 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:04:13 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:04:13 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:04:13 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:04:13 ppp 42670 [wan_link0] Link: reconnection attempt 2 in 2 seconds
                                          Dec 7 02:04:15 ppp 42670 [wan_link0] Link: reconnection attempt 2
                                          Dec 7 02:04:15 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:04:24 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:04:24 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:04:24 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:04:24 ppp 42670 [wan_link0] Link: reconnection attempt 3 in 4 seconds
                                          Dec 7 02:04:28 ppp 42670 [wan_link0] Link: reconnection attempt 3
                                          Dec 7 02:04:28 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:04:37 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:04:37 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:04:37 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:04:37 ppp 42670 [wan_link0] Link: reconnection attempt 4 in 4 seconds
                                          Dec 7 02:04:41 ppp 42670 [wan_link0] Link: reconnection attempt 4
                                          Dec 7 02:04:41 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:04:50 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:04:50 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:04:50 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:04:50 ppp 42670 [wan_link0] Link: reconnection attempt 5 in 1 seconds
                                          Dec 7 02:04:51 ppp 42670 [wan_link0] Link: reconnection attempt 5
                                          Dec 7 02:04:51 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:05:00 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:05:00 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:05:00 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:05:00 ppp 42670 [wan_link0] Link: reconnection attempt 6 in 3 seconds
                                          Dec 7 02:05:03 ppp 42670 [wan_link0] Link: reconnection attempt 6
                                          Dec 7 02:05:03 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:05:12 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:05:12 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:05:12 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:05:12 ppp 42670 [wan_link0] Link: reconnection attempt 7 in 1 seconds
                                          Dec 7 02:05:13 ppp 42670 [wan_link0] Link: reconnection attempt 7
                                          Dec 7 02:05:13 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:05:22 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:05:22 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:05:22 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:05:22 ppp 42670 [wan_link0] Link: reconnection attempt 8 in 3 seconds
                                          Dec 7 02:05:25 ppp 42670 [wan_link0] Link: reconnection attempt 8
                                          Dec 7 02:05:25 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:05:34 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:05:34 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:05:34 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:05:34 ppp 42670 [wan_link0] Link: reconnection attempt 9 in 2 seconds
                                          Dec 7 02:05:36 ppp 42670 [wan_link0] Link: reconnection attempt 9
                                          Dec 7 02:05:36 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:05:45 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:05:45 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:05:45 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:05:45 ppp 42670 [wan_link0] Link: reconnection attempt 10 in 1 seconds
                                          Dec 7 02:05:46 ppp 42670 [wan_link0] Link: reconnection attempt 10
                                          Dec 7 02:05:46 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:05:55 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:05:55 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:05:55 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:05:55 ppp 42670 [wan_link0] Link: reconnection attempt 11 in 4 seconds
                                          Dec 7 02:05:59 ppp 42670 [wan_link0] Link: reconnection attempt 11
                                          Dec 7 02:05:59 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:06:08 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:06:08 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:06:08 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:06:08 ppp 42670 [wan_link0] Link: reconnection attempt 12 in 3 seconds
                                          Dec 7 02:06:11 ppp 42670 [wan_link0] Link: reconnection attempt 12
                                          Dec 7 02:06:11 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:06:20 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:06:20 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:06:20 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:06:20 ppp 42670 [wan_link0] Link: reconnection attempt 13 in 2 seconds
                                          Dec 7 02:06:23 ppp 42670 [wan_link0] Link: reconnection attempt 13
                                          Dec 7 02:06:23 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:06:32 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:06:32 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:06:32 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:06:32 ppp 42670 [wan_link0] Link: reconnection attempt 14 in 1 seconds
                                          Dec 7 02:06:33 ppp 42670 [wan_link0] Link: reconnection attempt 14
                                          Dec 7 02:06:33 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:06:42 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:06:42 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:06:42 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:06:42 ppp 42670 [wan_link0] Link: reconnection attempt 15 in 1 seconds
                                          Dec 7 02:06:43 ppp 42670 [wan_link0] Link: reconnection attempt 15
                                          Dec 7 02:06:43 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:06:52 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:06:52 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:06:52 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:06:52 ppp 42670 [wan_link0] Link: reconnection attempt 16 in 4 seconds
                                          Dec 7 02:06:56 ppp 42670 [wan_link0] Link: reconnection attempt 16
                                          Dec 7 02:06:56 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:07:05 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:07:05 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:07:05 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:07:05 ppp 42670 [wan_link0] Link: reconnection attempt 17 in 4 seconds
                                          Dec 7 02:07:09 ppp 42670 [wan_link0] Link: reconnection attempt 17
                                          Dec 7 02:07:09 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:07:18 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:07:18 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:07:18 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:07:18 ppp 42670 [wan_link0] Link: reconnection attempt 18 in 4 seconds
                                          Dec 7 02:07:22 ppp 42670 [wan_link0] Link: reconnection attempt 18
                                          Dec 7 02:07:22 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:07:31 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:07:31 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:07:31 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:07:31 ppp 42670 [wan_link0] Link: reconnection attempt 19 in 4 seconds
                                          Dec 7 02:07:35 ppp 42670 [wan_link0] Link: reconnection attempt 19
                                          Dec 7 02:07:35 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:07:44 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:07:44 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:07:44 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:07:44 ppp 42670 [wan_link0] Link: reconnection attempt 20 in 2 seconds
                                          Dec 7 02:07:46 ppp 42670 [wan_link0] Link: reconnection attempt 20
                                          Dec 7 02:07:46 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:07:55 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:07:55 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:07:55 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:07:55 ppp 42670 [wan_link0] Link: reconnection attempt 21 in 2 seconds
                                          Dec 7 02:07:57 ppp 42670 [wan_link0] Link: reconnection attempt 21
                                          Dec 7 02:07:57 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:08:06 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:08:06 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:08:06 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:08:06 ppp 42670 [wan_link0] Link: reconnection attempt 22 in 3 seconds
                                          Dec 7 02:08:09 ppp 42670 [wan_link0] Link: reconnection attempt 22
                                          Dec 7 02:08:09 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:08:18 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:08:18 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:08:18 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:08:18 ppp 42670 [wan_link0] Link: reconnection attempt 23 in 1 seconds
                                          Dec 7 02:08:19 ppp 42670 [wan_link0] Link: reconnection attempt 23
                                          Dec 7 02:08:19 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:08:28 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:08:28 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:08:28 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:08:28 ppp 42670 [wan_link0] Link: reconnection attempt 24 in 1 seconds
                                          Dec 7 02:08:29 ppp 42670 [wan_link0] Link: reconnection attempt 24
                                          Dec 7 02:08:29 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:08:38 ppp 42670 [wan_link0] PPPoE connection timeout after 9 seconds
                                          Dec 7 02:08:38 ppp 42670 [wan_link0] Link: DOWN event
                                          Dec 7 02:08:38 ppp 42670 [wan_link0] LCP: Down event
                                          Dec 7 02:08:38 ppp 42670 [wan_link0] Link: reconnection attempt 25 in 1 seconds
                                          Dec 7 02:08:39 ppp 42670 [wan_link0] Link: reconnection attempt 25
                                          Dec 7 02:08:39 ppp 42670 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:09:44 ppp 7586 Multi-link PPP daemon for FreeBSD
                                          Dec 7 02:09:44 ppp 7586 process 7586 started, version 5.9
                                          Dec 7 02:09:44 ppp 7586 web: web is not running
                                          Dec 7 02:09:44 ppp 7586 [wan] Bundle: Interface ng0 created
                                          Dec 7 02:09:44 ppp 7586 [wan_link0] Link: OPEN event
                                          Dec 7 02:09:44 ppp 7586 [wan_link0] LCP: Open event
                                          Dec 7 02:09:44 ppp 7586 [wan_link0] LCP: state change Initial --> Starting
                                          Dec 7 02:09:44 ppp 7586 [wan_link0] LCP: LayerStart
                                          Dec 7 02:09:44 ppp 7586 [wan_link0] PPPoE: Connecting to ''
                                          Dec 7 02:09:47 ppp 7586 PPPoE: rec'd ACNAME "XXXXXXXXXXX"
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] PPPoE: connection successful
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] Link: UP event
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: Up event
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: state change Starting --> Req-Sent
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: SendConfigReq #1
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] PROTOCOMP
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MRU 1492
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MAGICNUM 0x32d558bc
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: rec'd Configure Request #174 (Req-Sent)
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MRU 1460
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] AUTHPROTO CHAP MD5
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MAGICNUM 0x3055284a
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: SendConfigAck #174
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MRU 1460
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] AUTHPROTO CHAP MD5
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MAGICNUM 0x3055284a
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: state change Req-Sent --> Ack-Sent
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: rec'd Configure Reject #1 (Ack-Sent)
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] PROTOCOMP
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: SendConfigReq #2
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MRU 1492
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MAGICNUM 0x32d558bc
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: rec'd Configure Nak #2 (Ack-Sent)
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MRU 1460
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: SendConfigReq #3
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MRU 1460
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MAGICNUM 0x32d558bc
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent)
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MRU 1460
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] MAGICNUM 0x32d558bc
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: state change Ack-Sent --> Opened
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: auth: peer wants CHAP, I want nothing
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] LCP: LayerUp
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] CHAP: rec'd CHALLENGE #1 len: 39
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] Name: "XXXXXXXXXXXX"
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] CHAP: Using authname "XXXXXXXX"
                                          Dec 7 02:09:47 ppp 7586 [wan_link0] CHAP: sending RESPONSE #1 len: 50
                                          Dec 7 02:09:48 ppp 7586 [wan_link0] CHAP: rec'd SUCCESS #1 len: 26
                                          Dec 7 02:09:48 ppp 7586 [wan_link0] MESG: Authentication Success
                                          Dec 7 02:09:48 ppp 7586 [wan_link0] LCP: authorization successful
                                          Dec 7 02:09:48 ppp 7586 [wan_link0] Link: Matched action 'bundle "wan" ""'
                                          Dec 7 02:09:48 ppp 7586 [wan_link0] Link: Join bundle "wan"
                                          Dec 7 02:09:48 ppp 7586 [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: Open event
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: state change Initial --> Starting
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: LayerStart
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: Up event
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: state change Starting --> Req-Sent
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: SendConfigReq #1
                                          Dec 7 02:09:48 ppp 7586 [wan] IPADDR 0.0.0.0
                                          Dec 7 02:09:48 ppp 7586 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: rec'd Configure Request #183 (Req-Sent)
                                          Dec 7 02:09:48 ppp 7586 [wan] IPADDR IP.ADDRESS..1
                                          Dec 7 02:09:48 ppp 7586 [wan] IP.ADDRESS..1 is OK
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: SendConfigAck #183
                                          Dec 7 02:09:48 ppp 7586 [wan] IPADDR IP.ADDRESS..1
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: state change Req-Sent --> Ack-Sent
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
                                          Dec 7 02:09:48 ppp 7586 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: SendConfigReq #2
                                          Dec 7 02:09:48 ppp 7586 [wan] IPADDR 0.0.0.0
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
                                          Dec 7 02:09:48 ppp 7586 [wan] IPADDR IP.ADDRESS..163
                                          Dec 7 02:09:48 ppp 7586 [wan] IP.ADDRESS..163 is OK
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: SendConfigReq #3
                                          Dec 7 02:09:48 ppp 7586 [wan] IPADDR IP.ADDRESS..163
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
                                          Dec 7 02:09:48 ppp 7586 [wan] IPADDR IP.ADDRESS..163
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: state change Ack-Sent --> Opened
                                          Dec 7 02:09:48 ppp 7586 [wan] IPCP: LayerUp
                                          Dec 7 02:09:48 ppp 7586 [wan] IP.ADDRESS..163 -> IP.ADDRESS..1
                                          Dec 7 02:09:48 ppp 7586 [wan] IFACE: Up event
                                          Dec 7 02:09:48 ppp 7586 [wan] IFACE: Rename interface ng0 to pppoe0

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

                                            That's the ppp log I assume? I don't see the link state change shown.

                                            At what point did you run the test? What did you do to reconnect again?

                                            Steve

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