WAN (PPPoE) down and not reconnecting
-
yesterday my WAN-if went down and didn't come back up by itself. I did not have time for deeper investigation so I restarted the whole pfsense every time it happend. After the reboot WAN was available again.
Here's what's in the log for the moment it happened (entries like that continue until the reboot):
Sep 3 20:01:05 ppp 14796 [wan_link0] LCP: no reply to 1 echo request(s) Sep 3 20:01:13 php-fpm 350 /rc.newipsecdns: IPSEC: One or more IPsec tunnel endpoints has changed its IP. Refreshing. Sep 3 20:01:13 check_reload_status 388 Reloading filter Sep 3 20:01:15 ppp 14796 [wan_link0] LCP: no reply to 2 echo request(s) Sep 3 20:01:25 ppp 14796 [wan_link0] LCP: no reply to 3 echo request(s) Sep 3 20:01:35 ppp 14796 [wan_link0] LCP: no reply to 4 echo request(s) Sep 3 20:01:42 check_reload_status 388 Restarting ipsec tunnels Sep 3 20:01:45 ppp 14796 [wan_link0] LCP: no reply to 5 echo request(s) Sep 3 20:01:45 ppp 14796 [wan_link0] LCP: peer not responding to echo requests Sep 3 20:01:45 ppp 14796 [wan_link0] LCP: state change Opened --> Stopping Sep 3 20:01:45 ppp 14796 [wan_link0] Link: Leave bundle "wan" Sep 3 20:01:45 ppp 14796 [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps Sep 3 20:01:45 ppp 14796 [wan] IPCP: Close event Sep 3 20:01:45 ppp 14796 [wan] IPCP: state change Opened --> Closing Sep 3 20:01:45 ppp 14796 [wan] IPCP: SendTerminateReq #4 Sep 3 20:01:45 ppp 14796 [wan] IPCP: LayerDown Sep 3 20:01:46 check_reload_status 388 Rewriting resolv.conf Sep 3 20:01:46 ppp 14796 [wan] IPV6CP: Close event Sep 3 20:01:46 ppp 14796 [wan] IPV6CP: state change Opened --> Closing Sep 3 20:01:46 ppp 14796 [wan] IPV6CP: SendTerminateReq #2 Sep 3 20:01:46 ppp 14796 [wan] IPV6CP: LayerDown Sep 3 20:01:50 check_reload_status 388 Rewriting resolv.conf Sep 3 20:01:50 ppp 14796 [wan] IFACE: Down event Sep 3 20:01:50 ppp 14796 [wan] IFACE: Rename interface pppoe1 to pppoe1 Sep 3 20:01:50 ppp 14796 [wan] IPCP: Down event Sep 3 20:01:50 ppp 14796 [wan] IPCP: LayerFinish Sep 3 20:01:50 ppp 14796 [wan] IPCP: state change Closing --> Initial Sep 3 20:01:50 ppp 14796 [wan] IPV6CP: Down event Sep 3 20:01:50 ppp 14796 [wan] IPV6CP: LayerFinish Sep 3 20:01:50 ppp 14796 [wan] Bundle: No NCPs left. Closing links... Sep 3 20:01:50 ppp 14796 [wan] IPV6CP: state change Closing --> Initial Sep 3 20:01:50 ppp 14796 [wan_link0] LCP: SendTerminateReq #2 Sep 3 20:01:50 ppp 14796 [wan_link0] LCP: LayerDown Sep 3 20:01:56 ppp 14796 [wan_link0] LCP: SendTerminateReq #3 Sep 3 20:01:58 ppp 14796 [wan_link0] LCP: state change Stopping --> Stopped Sep 3 20:01:58 ppp 14796 [wan_link0] LCP: LayerFinish Sep 3 20:01:58 ppp 14796 [wan_link0] PPPoE: connection closed Sep 3 20:01:58 ppp 14796 [wan_link0] Link: DOWN event Sep 3 20:01:58 ppp 14796 [wan_link0] LCP: Down event Sep 3 20:01:58 ppp 14796 [wan_link0] LCP: state change Stopped --> Starting Sep 3 20:01:58 ppp 14796 [wan_link0] LCP: LayerStart Sep 3 20:01:58 ppp 14796 [wan_link0] Link: reconnection attempt 1 in 1 seconds Sep 3 20:01:59 ppp 14796 [wan_link0] Link: reconnection attempt 1 Sep 3 20:01:59 ppp 14796 [wan_link0] PPPoE: Connecting to '' Sep 3 20:02:01 php-fpm 350 /rc.newipsecdns: WARNING: Setting i_dont_care_about_security_and_use_aggressive_mode_psk option because a phase 1 is configured using aggressive mode with pre-shared keys. This is not a secure configuration. Sep 3 20:02:02 php-fpm 350 /rc.newipsecdns: Warning: Missing CRL data for OVPN_CRL Sep 3 20:02:08 ppp 14796 [wan_link0] PPPoE connection timeout after 9 seconds Sep 3 20:02:08 ppp 14796 [wan_link0] Link: DOWN event Sep 3 20:02:08 ppp 14796 [wan_link0] LCP: Down event Sep 3 20:02:08 ppp 14796 [wan_link0] Link: reconnection attempt 2 in 2 seconds Sep 3 20:02:10 ppp 14796 [wan_link0] Link: reconnection attempt 2 Sep 3 20:02:10 ppp 14796 [wan_link0] PPPoE: Connecting to '' Sep 3 20:02:17 php-fpm 99598 /rc.newipsecdns: IPSEC: One or more IPsec tunnel endpoints has changed its IP. Refreshing. Sep 3 20:02:17 check_reload_status 388 Reloading filter Sep 3 20:02:18 php-fpm 99598 /rc.newipsecdns: IPsec ERROR: Could not find phase 1 source for connection VPN zu Hani. Omitting from configuration file. Sep 3 20:02:18 php-fpm 99598 /rc.newipsecdns: WARNING: Setting i_dont_care_about_security_and_use_aggressive_mode_psk option because a phase 1 is configured using aggressive mode with pre-shared keys. This is not a secure configuration. Sep 3 20:02:18 php-fpm 99598 /rc.newipsecdns: Warning: Missing CRL data for OVPN_CRL Sep 3 20:02:19 ppp 14796 [wan_link0] PPPoE connection timeout after 9 seconds Sep 3 20:02:19 ppp 14796 [wan_link0] Link: DOWN event Sep 3 20:02:19 ppp 14796 [wan_link0] LCP: Down event Sep 3 20:02:19 ppp 14796 [wan_link0] Link: reconnection attempt 3 in 4 seconds Sep 3 20:02:23 ppp 14796 [wan_link0] Link: reconnection attempt 3 Sep 3 20:02:23 ppp 14796 [wan_link0] PPPoE: Connecting to '' Sep 3 20:02:32 ppp 14796 [wan_link0] PPPoE connection timeout after 9 seconds Sep 3 20:02:32 ppp 14796 [wan_link0] Link: DOWN event Sep 3 20:02:32 ppp 14796 [wan_link0] LCP: Down event Sep 3 20:02:32 ppp 14796 [wan_link0] Link: reconnection attempt 4 in 4 seconds Sep 3 20:02:36 ppp 14796 [wan_link0] Link: reconnection attempt 4 Sep 3 20:02:36 ppp 14796 [wan_link0] PPPoE: Connecting to '' Sep 3 20:02:45 ppp 14796 [wan_link0] PPPoE connection timeout after 9 seconds Sep 3 20:02:45 ppp 14796 [wan_link0] Link: DOWN event Sep 3 20:02:45 ppp 14796 [wan_link0] LCP: Down event Sep 3 20:02:45 ppp 14796 [wan_link0] Link: reconnection attempt 5 in 2 seconds Sep 3 20:02:47 ppp 14796 [wan_link0] Link: reconnection attempt 5 Sep 3 20:02:47 ppp 14796 [wan_link0] PPPoE: Connecting to '' Sep 3 20:02:56 ppp 14796 [wan_link0] PPPoE connection timeout after 9 seconds Sep 3 20:02:56 ppp 14796 [wan_link0] Link: DOWN event Sep 3 20:02:56 ppp 14796 [wan_link0] LCP: Down event Sep 3 20:02:56 ppp 14796 [wan_link0] Link: reconnection attempt 6 in 2 seconds Sep 3 20:02:58 ppp 14796 [wan_link0] Link: reconnection attempt 6 Sep 3 20:02:58 ppp 14796 [wan_link0] PPPoE: Connecting to ''
I want to find the source of that problem (maybe it's ISP related, however my pfsense must not stuck in that condition without coming back online by itself)
-
It's still trying to connect.
Rebooting would remake the link to the modem. If you disconnect and reconnect the link between the pfSense WAN and modem does that also allow it to come up?
Steve
-
@stephenw10 no, re-connecting the cable does not bring connectivity back