Reverse Tunnelling
-
Hi All,
I have a pfsense box running 2.2.3 and this is use as a backup option in case my main firewall have any hardware issue. I have got a 3G dongle which I have got it to work with the pfsense box but the problem is that the WAN IP is not publicly available.
I would like to know how I can configure the pfsense box to connect to another production pfsense box with public IP (something like a reverse SSH)? Can we configure such that when the standby pfsense box is powered on, it will auto-connect to my production pfsense box and then I can access the remote side through that connection.
Office 1 –--- Production FW1 <----- IPSec tunnel -----> Production FW2 ---- Office 2
|--- Standby FW <----- ????? -------------->As IPSec to IPSec VPN tunnel requires public IP, I cannot do that for this setup.
Any comments?
-
OpenVPN should work as it can do a client -> server setup.
-
I have tried to configure OpenVPN in client -> Server setup on my pfsense box but it doesn't work. Is there an example on how to do this on pfsense?
-
https://doc.pfsense.org/index.php/OpenVPN_Site_To_Site
The server has to be on the end with the public IP. The client can come from behind some non-public ISP thing. I have a few of these from small offices without public IP up to the main office. It works.
-
Hi All,
Thanks to Phil, I have setup my OpenVPN Server to Client and got it to work but I have another problem. The WAN is using a 3G dongle and after sometime, pfsense disabled the WAN interface, I think due to inactivity.
In the case where the WAN interface is disabled by the system, how do I enable it back using command line? Will a periodic ping to the OpenVPN server let the system left the WAN interface stay enabled?
Thanks & Regards.
-
OpenVPN itslef should keep the connection up via keep-alives. Gateway monitoring will also do that.
How does the WAN fail, what is logged? Is it connected via ppp? Do you have an idle timeout set?
Steve
-
From friday to monday, where there is no activity except my cron job to ping the OpenVPN server. I login on monday and access the webconfigurator page, check the dashboard and saw the WAN interface is disabled.
The WAN interface is configured to use PPP connection as this is a 3G dongle. I don't know if there is an idle timeout setting.
To bring the connection back on, I go to the WAN interface and click save and apply changes. Check the dashboard and the WAN interface is active again and the OpenVPN client is connecting to my remote server.
-
The WAN is actually disabled? Or just down?
We'd need to see what is logged in the system or ppp logs to have any idea why that happened.
The idle timeout is in the ppp settings. It's usually set to 0 (disabled) by default.
Steve
-
On 22 May at around 03:08 AM, the connection went down and on 25 May at around 12:07 PM, I login and found the WAN interface is disabled, I went to enable it back on.
Content of system.log when the connection broke:
May 22 03:08:17 myfw01s ppp: [wan_link0] LCP: rec'd Terminate Request #10 (Opened) May 22 03:08:17 myfw01s ppp: [wan_link0] LCP: state change Opened --> Stopping May 22 03:08:17 myfw01s ppp: [wan_link0] Link: Leave bundle "wan" May 22 03:08:17 myfw01s ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 22 03:08:17 myfw01s ppp: [wan] IPCP: Close event May 22 03:08:17 myfw01s ppp: [wan] IPCP: state change Opened --> Closing May 22 03:08:17 myfw01s ppp: [wan] IPCP: SendTerminateReq #19 May 22 03:08:17 myfw01s ppp: [wan] IPCP: LayerDown May 22 03:08:17 myfw01s check_reload_status: Rewriting resolv.conf May 22 03:08:17 myfw01s ppp: [wan] IFACE: Delete route 0.0.0.0/0 10.64.64.0 failed: No such process May 22 03:08:17 myfw01s ppp: [wan] IFACE: Down event May 22 03:08:17 myfw01s ppp: [wan] IFACE: Rename interface ppp0 to ppp0 May 22 03:08:17 myfw01s ppp: [wan] IPV6CP: Close event May 22 03:08:17 myfw01s ppp: [wan] IPV6CP: state change Stopped --> Closed May 22 03:08:17 myfw01s ppp: [wan] IPCP: Down event May 22 03:08:17 myfw01s ppp: [wan] IPCP: LayerFinish May 22 03:08:17 myfw01s ppp: [wan] Bundle: No NCPs left. Closing links... May 22 03:08:17 myfw01s ppp: [wan] IPCP: state change Closing --> Initial May 22 03:08:17 myfw01s ppp: [wan] IPV6CP: Down event May 22 03:08:17 myfw01s ppp: [wan] IPV6CP: state change Closed --> Initial May 22 03:08:17 myfw01s ppp: [wan_link0] LCP: SendTerminateAck #6 May 22 03:08:17 myfw01s ppp: [wan_link0] LCP: LayerDown May 22 03:08:19 myfw01s ppp: [wan_link0] LCP: state change Stopping --> Stopped May 22 03:08:19 myfw01s ppp: [wan_link0] LCP: LayerFinish May 22 03:08:19 myfw01s ppp: [wan_link0] Link: DOWN event May 22 03:08:19 myfw01s ppp: [wan_link0] LCP: Down event May 22 03:08:19 myfw01s ppp: [wan_link0] LCP: state change Stopped --> Starting May 22 03:08:19 myfw01s ppp: [wan_link0] LCP: LayerStart May 22 03:08:19 myfw01s ppp: [wan_link0] Link: reconnection attempt 1 in 2 seconds May 22 03:08:21 myfw01s ppp: [wan_link0] Link: reconnection attempt 1 May 22 03:08:22 myfw01s ppp: [wan_link0] CHAT: Detected Hayes compatible modem. May 22 03:08:22 myfw01s ppp: [wan_link0] CHAT: Dialing server at *99#... May 22 03:08:22 myfw01s ppp: [wan_link0] CHAT: ATDT*99# May 22 03:08:22 myfw01s ppp: [wan_link0] CHAT: Connected at an unknown speed. May 22 03:08:22 myfw01s ppp: [wan_link0] MODEM: chat script succeeded May 22 03:08:22 myfw01s ppp: [wan_link0] Link: UP event May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: Up event May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: state change Starting --> Req-Sent May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: SendConfigReq #7 May 22 03:08:22 myfw01s ppp: [wan_link0] ACFCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] PROTOCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] ACCMAP 0x000a0000 May 22 03:08:22 myfw01s ppp: [wan_link0] MRU 1500 May 22 03:08:22 myfw01s ppp: [wan_link0] MAGICNUM 31e51da2 May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: rec'd Configure Request #11 (Req-Sent) May 22 03:08:22 myfw01s ppp: [wan_link0] ACCMAP 0x00000000 May 22 03:08:22 myfw01s ppp: [wan_link0] AUTHPROTO CHAP MD5 May 22 03:08:22 myfw01s ppp: [wan_link0] MAGICNUM 0da69c92 May 22 03:08:22 myfw01s ppp: [wan_link0] PROTOCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] ACFCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: SendConfigAck #11 May 22 03:08:22 myfw01s ppp: [wan_link0] ACCMAP 0x00000000 May 22 03:08:22 myfw01s ppp: [wan_link0] AUTHPROTO CHAP MD5 May 22 03:08:22 myfw01s ppp: [wan_link0] MAGICNUM 0da69c92 May 22 03:08:22 myfw01s ppp: [wan_link0] PROTOCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] ACFCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: rec'd Configure Ack #7 (Ack-Sent) May 22 03:08:22 myfw01s ppp: [wan_link0] ACFCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] PROTOCOMP May 22 03:08:22 myfw01s ppp: [wan_link0] ACCMAP 0x000a0000 May 22 03:08:22 myfw01s ppp: [wan_link0] MRU 1500 May 22 03:08:22 myfw01s ppp: [wan_link0] MAGICNUM 31e51da2 May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: state change Ack-Sent --> Opened May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: auth: peer wants CHAP, I want nothing May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: LayerUp May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: rec'd Discard Request #12 (Opened) May 22 03:08:22 myfw01s ppp: [wan_link0] CHAP: rec'd CHALLENGE #1 len: 35 May 22 03:08:22 myfw01s ppp: [wan_link0] Name: "UMTS_CHAP_SRVR" May 22 03:08:22 myfw01s ppp: [wan_link0] CHAP: Using authname "user" May 22 03:08:22 myfw01s ppp: [wan_link0] CHAP: sending RESPONSE #1 len: 25 May 22 03:08:22 myfw01s ppp: [wan_link0] CHAP: rec'd SUCCESS #1 len: 4 May 22 03:08:22 myfw01s ppp: [wan_link0] LCP: authorization successful May 22 03:08:22 myfw01s ppp: [wan_link0] Link: Matched action 'bundle "wan" ""' May 22 03:08:22 myfw01s ppp: [wan_link0] Link: Join bundle "wan" May 22 03:08:22 myfw01s ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 28800 bps May 22 03:08:22 myfw01s ppp: [wan] IPCP: Open event May 22 03:08:22 myfw01s ppp: [wan] IPCP: state change Initial --> Starting May 22 03:08:22 myfw01s ppp: [wan] IPCP: LayerStart May 22 03:08:22 myfw01s ppp: [wan] IPV6CP: Open event May 22 03:08:22 myfw01s ppp: [wan] IPV6CP: state change Initial --> Starting May 22 03:08:22 myfw01s ppp: [wan] IPV6CP: LayerStart May 22 03:08:22 myfw01s ppp: [wan] IPCP: Up event May 22 03:08:22 myfw01s ppp: [wan] IPCP: state change Starting --> Req-Sent May 22 03:08:22 myfw01s ppp: [wan] IPCP: SendConfigReq #20 May 22 03:08:22 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:22 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:22 myfw01s ppp: [wan] PRIDNS 0.0.0.0 May 22 03:08:22 myfw01s ppp: [wan] SECDNS 0.0.0.0 May 22 03:08:22 myfw01s ppp: [wan] IPV6CP: Up event May 22 03:08:22 myfw01s ppp: [wan] IPV6CP: state change Starting --> Req-Sent May 22 03:08:22 myfw01s ppp: [wan] IPV6CP: SendConfigReq #31 May 22 03:08:23 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #20 (Req-Sent) May 22 03:08:23 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:23 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:23 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:23 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:23 myfw01s ppp: [wan] IPCP: SendConfigReq #21 May 22 03:08:23 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:23 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:23 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:23 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:24 myfw01s ppp: [wan] IPV6CP: SendConfigReq #32 May 22 03:08:24 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #21 (Req-Sent) May 22 03:08:24 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:24 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:24 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:24 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:24 myfw01s ppp: [wan] IPCP: SendConfigReq #22 May 22 03:08:24 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:24 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:24 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:24 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:25 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #22 (Req-Sent) May 22 03:08:25 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:25 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:25 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:25 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:25 myfw01s ppp: [wan] IPCP: SendConfigReq #23 May 22 03:08:25 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:25 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:25 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:25 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:26 myfw01s ppp: [wan] IPV6CP: SendConfigReq #33 May 22 03:08:26 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #23 (Req-Sent) May 22 03:08:26 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:26 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:26 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:26 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:26 myfw01s ppp: [wan] IPCP: SendConfigReq #24 May 22 03:08:26 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:26 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:26 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:26 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:27 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #24 (Req-Sent) May 22 03:08:27 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:27 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:27 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:27 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:27 myfw01s ppp: [wan] IPCP: SendConfigReq #25 May 22 03:08:27 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:27 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:27 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:27 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:28 myfw01s ppp: [wan] IPV6CP: SendConfigReq #34 May 22 03:08:28 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #25 (Req-Sent) May 22 03:08:28 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:28 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:28 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:28 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:28 myfw01s ppp: [wan] IPCP: SendConfigReq #26 May 22 03:08:28 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:28 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:28 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:28 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:29 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #26 (Req-Sent) May 22 03:08:29 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:29 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:29 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:29 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:29 myfw01s ppp: [wan] IPCP: SendConfigReq #27 May 22 03:08:29 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:29 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:29 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:29 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:30 myfw01s ppp: [wan] IPV6CP: SendConfigReq #35 May 22 03:08:30 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #27 (Req-Sent) May 22 03:08:30 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:30 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:30 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:30 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:30 myfw01s ppp: [wan] IPCP: SendConfigReq #28 May 22 03:08:30 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:30 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:30 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:30 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:31 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #28 (Req-Sent) May 22 03:08:31 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:31 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:31 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:31 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:31 myfw01s ppp: [wan] IPCP: SendConfigReq #29 May 22 03:08:31 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:31 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:31 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:31 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:32 myfw01s ppp: [wan] IPV6CP: SendConfigReq #36 May 22 03:08:32 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #29 (Req-Sent) May 22 03:08:32 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:32 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:32 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:32 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:32 myfw01s ppp: [wan] IPCP: not converging May 22 03:08:32 myfw01s ppp: [wan] IPCP: parameter negotiation failed May 22 03:08:32 myfw01s ppp: [wan] IPCP: state change Req-Sent --> Stopped May 22 03:08:32 myfw01s ppp: [wan] IPCP: LayerFinish May 22 03:08:34 myfw01s ppp: [wan] IPV6CP: SendConfigReq #37 May 22 03:08:36 myfw01s ppp: [wan] IPV6CP: SendConfigReq #38 May 22 03:08:38 myfw01s ppp: [wan] IPV6CP: SendConfigReq #39 May 22 03:08:40 myfw01s ppp: [wan] IPV6CP: SendConfigReq #40 May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: parameter negotiation failed May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: state change Req-Sent --> Stopped May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: LayerFinish May 22 03:08:42 myfw01s ppp: [wan] Bundle: No NCPs left. Closing links... May 22 03:08:42 myfw01s ppp: [wan] Bundle: closing link "wan_link0"... May 22 03:08:42 myfw01s ppp: [wan_link0] Link: CLOSE event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: Close event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: state change Opened --> Closing May 22 03:08:42 myfw01s ppp: [wan_link0] Link: Leave bundle "wan" May 22 03:08:42 myfw01s ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 22 03:08:42 myfw01s ppp: [wan] IPCP: Close event May 22 03:08:42 myfw01s ppp: [wan] IPCP: state change Stopped --> Closed May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: Close event May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: state change Stopped --> Closed May 22 03:08:42 myfw01s ppp: [wan] IPCP: Down event May 22 03:08:42 myfw01s ppp: [wan] IPCP: state change Closed --> Initial May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: Down event May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: state change Closed --> Initial May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: SendTerminateReq #8 May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: LayerDown May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: rec'd Terminate Ack #8 (Closing) May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: state change Closing --> Closed May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: LayerFinish May 22 03:08:42 myfw01s ppp: [wan_link0] Link: DOWN event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: Down event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: state change Closed --> Initial May 22 03:09:14 myfw01s kernel: ovpnc1: link state changed to DOWN May 22 03:09:14 myfw01s check_reload_status: Reloading filter May 22 03:09:15 myfw01s php-fpm[23463]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). May 22 03:09:15 myfw01s php-fpm[23463]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). May 23 01:01:00 myfw01s php: rc.dyndns.update: DynDns: updatedns() starting May 23 01:01:00 myfw01s php: rc.dyndns.update: DynDNS (myfw01s.mooo.com): running get_failover_interface for wan. found ppp0 May 23 01:01:00 myfw01s php: rc.dyndns.update: DynDNS (myfw01s.mooo.com) There was an error trying to determine the public IP for interface - wan(ppp0). Probably interface is not a WAN interface. May 24 01:01:00 myfw01s php: rc.dyndns.update: DynDns: updatedns() starting May 24 01:01:00 myfw01s php: rc.dyndns.update: DynDNS (myfw01s.mooo.com): running get_failover_interface for wan. found ppp0 May 24 01:01:00 myfw01s php: rc.dyndns.update: DynDNS (myfw01s.mooo.com) There was an error trying to determine the public IP for interface - wan(ppp0). Probably interface is not a WAN interface. May 25 01:01:00 myfw01s php: rc.dyndns.update: DynDns: updatedns() starting May 25 01:01:00 myfw01s php: rc.dyndns.update: DynDNS (myfw01s.mooo.com): running get_failover_interface for wan. found ppp0 May 25 01:01:00 myfw01s php: rc.dyndns.update: DynDNS (myfw01s.mooo.com) There was an error trying to determine the public IP for interface - wan(ppp0). Probably interface is not a WAN interface. May 25 12:07:37 myfw01s php-fpm[23463]: /index.php: Successful login for user 'lawrence' from: 10.60.3.1 May 25 12:07:37 myfw01s php-fpm[23463]: /index.php: Successful login for user 'lawrence' from: 10.60.3.1 May 25 12:08:13 myfw01s check_reload_status: Syncing firewall May 25 12:08:15 myfw01s ppp: caught fatal signal TERM May 25 12:08:15 myfw01s ppp: [wan] IFACE: Close event May 25 12:08:15 myfw01s ppp: [wan] IPCP: Close event May 25 12:08:15 myfw01s ppp: [wan] IPV6CP: Close event May 25 12:08:17 myfw01s ppp: [wan] Bundle: Shutdown May 25 12:08:17 myfw01s ppp: [wan_link0] Link: Shutdown May 25 12:08:17 myfw01s ppp: process 6163 terminated May 25 12:08:17 myfw01s ppp: Multi-link PPP daemon for FreeBSD May 25 12:08:17 myfw01s ppp: May 25 12:08:17 myfw01s ppp: process 12576 started, version 5.7 (root@pfSense_RELENG_2_2_amd64_amd64-pfSense_RELENG_2_2-job-01 00:07 9-Jun-2015) May 25 12:08:17 myfw01s ppp: web: web is not running May 25 12:08:17 myfw01s ppp: [wan] Bundle: Interface ng0 created May 25 12:08:17 myfw01s ppp: [wan_link0] Link: OPEN event May 25 12:08:17 myfw01s kernel: ng0: changing name to 'ppp0' May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: Open event May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: state change Initial --> Starting May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: LayerStart May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: +CGDCONT=1,"IP","celcom3g" May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: Detected Hayes compatible modem. May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: Dialing server at *99#... May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: ATDT*99# May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: Connected at an unknown speed. May 25 12:08:17 myfw01s ppp: [wan_link0] MODEM: chat script succeeded May 25 12:08:17 myfw01s ppp: [wan_link0] Link: UP event May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: Up event May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: state change Starting --> Req-Sent May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: SendConfigReq #1 May 25 12:08:17 myfw01s ppp: [wan_link0] ACFCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] PROTOCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] ACCMAP 0x000a0000 May 25 12:08:17 myfw01s ppp: [wan_link0] MRU 1500 May 25 12:08:17 myfw01s ppp: [wan_link0] MAGICNUM 4c164a60 May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: rec'd Configure Request #13 (Req-Sent) May 25 12:08:17 myfw01s ppp: [wan_link0] ACCMAP 0x00000000 May 25 12:08:17 myfw01s ppp: [wan_link0] AUTHPROTO CHAP MD5 May 25 12:08:17 myfw01s ppp: [wan_link0] MAGICNUM 1f061408 May 25 12:08:17 myfw01s ppp: [wan_link0] PROTOCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] ACFCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: SendConfigAck #13 May 25 12:08:17 myfw01s ppp: [wan_link0] ACCMAP 0x00000000 May 25 12:08:17 myfw01s ppp: [wan_link0] AUTHPROTO CHAP MD5 May 25 12:08:17 myfw01s ppp: [wan_link0] MAGICNUM 1f061408 May 25 12:08:17 myfw01s ppp: [wan_link0] PROTOCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] ACFCOMP
Content of ppp.log when the connection broke:
May 22 03:08:31 myfw01s ppp: [wan] IPCP: SendConfigReq #29 May 22 03:08:31 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 22 03:08:31 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 22 03:08:31 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:31 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:32 myfw01s ppp: [wan] IPV6CP: SendConfigReq #36 May 22 03:08:32 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #29 (Req-Sent) May 22 03:08:32 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 22 03:08:32 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 22 03:08:32 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 22 03:08:32 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 22 03:08:32 myfw01s ppp: [wan] IPCP: not converging May 22 03:08:32 myfw01s ppp: [wan] IPCP: parameter negotiation failed May 22 03:08:32 myfw01s ppp: [wan] IPCP: state change Req-Sent --> Stopped May 22 03:08:32 myfw01s ppp: [wan] IPCP: LayerFinish May 22 03:08:34 myfw01s ppp: [wan] IPV6CP: SendConfigReq #37 May 22 03:08:36 myfw01s ppp: [wan] IPV6CP: SendConfigReq #38 May 22 03:08:38 myfw01s ppp: [wan] IPV6CP: SendConfigReq #39 May 22 03:08:40 myfw01s ppp: [wan] IPV6CP: SendConfigReq #40 May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: parameter negotiation failed May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: state change Req-Sent --> Stopped May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: LayerFinish May 22 03:08:42 myfw01s ppp: [wan] Bundle: No NCPs left. Closing links... May 22 03:08:42 myfw01s ppp: [wan] Bundle: closing link "wan_link0"... May 22 03:08:42 myfw01s ppp: [wan_link0] Link: CLOSE event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: Close event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: state change Opened --> Closing May 22 03:08:42 myfw01s ppp: [wan_link0] Link: Leave bundle "wan" May 22 03:08:42 myfw01s ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 22 03:08:42 myfw01s ppp: [wan] IPCP: Close event May 22 03:08:42 myfw01s ppp: [wan] IPCP: state change Stopped --> Closed May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: Close event May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: state change Stopped --> Closed May 22 03:08:42 myfw01s ppp: [wan] IPCP: Down event May 22 03:08:42 myfw01s ppp: [wan] IPCP: state change Closed --> Initial May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: Down event May 22 03:08:42 myfw01s ppp: [wan] IPV6CP: state change Closed --> Initial May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: SendTerminateReq #8 May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: LayerDown May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: rec'd Terminate Ack #8 (Closing) May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: state change Closing --> Closed May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: LayerFinish May 22 03:08:42 myfw01s ppp: [wan_link0] Link: DOWN event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: Down event May 22 03:08:42 myfw01s ppp: [wan_link0] LCP: state change Closed --> Initial May 25 12:08:15 myfw01s ppp: caught fatal signal TERM May 25 12:08:15 myfw01s ppp: [wan] IFACE: Close event May 25 12:08:15 myfw01s ppp: [wan] IPCP: Close event May 25 12:08:15 myfw01s ppp: [wan] IPV6CP: Close event May 25 12:08:17 myfw01s ppp: [wan] Bundle: Shutdown May 25 12:08:17 myfw01s ppp: [wan_link0] Link: Shutdown May 25 12:08:17 myfw01s ppp: process 6163 terminated May 25 12:08:17 myfw01s ppp: Multi-link PPP daemon for FreeBSD May 25 12:08:17 myfw01s ppp: May 25 12:08:17 myfw01s ppp: process 12576 started, version 5.7 (root@pfSense_RELENG_2_2_amd64_amd64-pfSense_RELENG_2_2-job-01 00:07 9-Jun-2015) May 25 12:08:17 myfw01s ppp: web: web is not running May 25 12:08:17 myfw01s ppp: [wan] Bundle: Interface ng0 created May 25 12:08:17 myfw01s ppp: [wan_link0] Link: OPEN event May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: Open event May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: state change Initial --> Starting May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: LayerStart May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: +CGDCONT=1,"IP","celcom3g" May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: Detected Hayes compatible modem. May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: Dialing server at *99#... May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: ATDT*99# May 25 12:08:17 myfw01s ppp: [wan_link0] CHAT: Connected at an unknown speed. May 25 12:08:17 myfw01s ppp: [wan_link0] MODEM: chat script succeeded May 25 12:08:17 myfw01s ppp: [wan_link0] Link: UP event May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: Up event May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: state change Starting --> Req-Sent May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: SendConfigReq #1 May 25 12:08:17 myfw01s ppp: [wan_link0] ACFCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] PROTOCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] ACCMAP 0x000a0000 May 25 12:08:17 myfw01s ppp: [wan_link0] MRU 1500 May 25 12:08:17 myfw01s ppp: [wan_link0] MAGICNUM 4c164a60 May 25 12:08:17 myfw01s ppp: [wan_link0] LCP: rec'd Configure Request #13 (Req-Sent) May 25 12:08:17 myfw01s ppp: [wan_link0] ACCMAP 0x00000000 May 25 12:08:17 myfw01s ppp: [wan_link0] AUTHPROTO CHAP MD5 May 25 12:08:17 myfw01s ppp: [wan_link0] MAGICNUM 1f061408 May 25 12:08:17 myfw01s ppp: [wan_link0] PROTOCOMP May 25 12:08:17 myfw01s ppp: [wan_link0] ACFCOMP
-
First log fragment, first line :
May 22 03:08:17 myfw01s ppp: [wan_link0] LCP: rec'd Terminate Request #10 (Opened)
Your PPP connection received a "Terminate Request".
So, the connection was being terminated properly, to be rebuild right away.
But :
When reconnecting, you have a lot ofMay 22 03:08:23 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #20 (Req-Sent)
What I make of it : the other side doesn't (or can't) give you an IPv4 WAN IP (two DNS's, yes, but no WAN IP).
There is a mismatch between send and received # config number (like 36 send and 29 received). The 3G connection went bad ?
-
Yeah, it looks like the provider does not send an IP address for the client to use for some reason.
Hard to say why it would actually be disabled though. Are you sure it is? It could just appear that way. Re-saving the interface kicks in a whole bunch of stuff.
Steve
-
I login today and found the WAN interface is offline and this is what is shown on the console:
*** Welcome to pfSense 2.2.3-RELEASE-nanobsd (amd64) on myfw01s *** WAN (wan) -> ppp0 -> LAN (lan) -> em1 -> v4: 10.60.3.10/16 0) Logout (SSH only) 9) pfTop 1) Assign Interfaces 10) Filter Logs 2) Set interface(s) IP address 11) Restart webConfigurator 3) Reset webConfigurator password 12) pfSense Developer Shell 4) Reset to factory defaults 13) Upgrade from console 5) Reboot system 14) Disable Secure Shell (sshd) 6) Halt system 15) Restore recent configuration 7) Ping host 16) Restart PHP-FPM 8) Shell Enter an option:
Looking at the system log, it does try to redial the connection but somehow it is not working to bring the WAN interface up.
May 31 14:18:05 myfw01s ppp: [wan_link0] LCP: rec'd Terminate Request #29 (Opened) May 31 14:18:05 myfw01s ppp: [wan_link0] LCP: state change Opened --> Stopping May 31 14:18:05 myfw01s ppp: [wan_link0] Link: Leave bundle "wan" May 31 14:18:05 myfw01s ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 31 14:18:05 myfw01s ppp: [wan] IPCP: Close event May 31 14:18:05 myfw01s ppp: [wan] IPCP: state change Opened --> Closing May 31 14:18:05 myfw01s ppp: [wan] IPCP: SendTerminateReq #17 May 31 14:18:05 myfw01s ppp: [wan] IPCP: LayerDown May 31 14:18:05 myfw01s check_reload_status: Rewriting resolv.conf May 31 14:18:05 myfw01s ppp: [wan] IFACE: Delete route 0.0.0.0/0 10.64.64.0 failed: No such process May 31 14:18:05 myfw01s ppp: [wan] IFACE: Down event May 31 14:18:05 myfw01s ppp: [wan] IFACE: Rename interface ppp0 to ppp0 May 31 14:18:05 myfw01s ppp: [wan] IPV6CP: Close event May 31 14:18:05 myfw01s ppp: [wan] IPV6CP: state change Stopped --> Closed May 31 14:18:05 myfw01s ppp: [wan] IPCP: Down event May 31 14:18:05 myfw01s ppp: [wan] IPCP: LayerFinish May 31 14:18:05 myfw01s ppp: [wan] Bundle: No NCPs left. Closing links... May 31 14:18:05 myfw01s ppp: [wan] IPCP: state change Closing --> Initial May 31 14:18:05 myfw01s ppp: [wan] IPV6CP: Down event May 31 14:18:05 myfw01s ppp: [wan] IPV6CP: state change Closed --> Initial May 31 14:18:05 myfw01s ppp: [wan_link0] LCP: SendTerminateAck #4 May 31 14:18:05 myfw01s ppp: [wan_link0] LCP: LayerDown May 31 14:18:07 myfw01s ppp: [wan_link0] LCP: state change Stopping --> Stopped May 31 14:18:07 myfw01s ppp: [wan_link0] LCP: LayerFinish May 31 14:18:08 myfw01s ppp: [wan_link0] Link: DOWN event May 31 14:18:08 myfw01s ppp: [wan_link0] LCP: Down event May 31 14:18:08 myfw01s ppp: [wan_link0] LCP: state change Stopped --> Starting May 31 14:18:08 myfw01s ppp: [wan_link0] LCP: LayerStart May 31 14:18:08 myfw01s ppp: [wan_link0] Link: reconnection attempt 1 in 1 seconds May 31 14:18:09 myfw01s ppp: [wan_link0] Link: reconnection attempt 1 May 31 14:18:11 myfw01s ppp: [wan_link0] CHAT: Detected Hayes compatible modem. May 31 14:18:11 myfw01s ppp: [wan_link0] CHAT: Dialing server at *99#... May 31 14:18:11 myfw01s ppp: [wan_link0] CHAT: ATDT*99# May 31 14:18:11 myfw01s ppp: [wan_link0] CHAT: Connected at an unknown speed. May 31 14:18:11 myfw01s ppp: [wan_link0] MODEM: chat script succeeded May 31 14:18:11 myfw01s ppp: [wan_link0] Link: UP event May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: Up event May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: state change Starting --> Req-Sent May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: SendConfigReq #5 May 31 14:18:11 myfw01s ppp: [wan_link0] ACFCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] PROTOCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] ACCMAP 0x000a0000 May 31 14:18:11 myfw01s ppp: [wan_link0] MRU 1500 May 31 14:18:11 myfw01s ppp: [wan_link0] MAGICNUM a6abc118 May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: rec'd Configure Request #30 (Req-Sent) May 31 14:18:11 myfw01s ppp: [wan_link0] ACCMAP 0x00000000 May 31 14:18:11 myfw01s ppp: [wan_link0] AUTHPROTO CHAP MD5 May 31 14:18:11 myfw01s ppp: [wan_link0] MAGICNUM 3e650d54 May 31 14:18:11 myfw01s ppp: [wan_link0] PROTOCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] ACFCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: SendConfigAck #30 May 31 14:18:11 myfw01s ppp: [wan_link0] ACCMAP 0x00000000 May 31 14:18:11 myfw01s ppp: [wan_link0] AUTHPROTO CHAP MD5 May 31 14:18:11 myfw01s ppp: [wan_link0] MAGICNUM 3e650d54 May 31 14:18:11 myfw01s ppp: [wan_link0] PROTOCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] ACFCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: rec'd Configure Ack #5 (Ack-Sent) May 31 14:18:11 myfw01s ppp: [wan_link0] ACFCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] PROTOCOMP May 31 14:18:11 myfw01s ppp: [wan_link0] ACCMAP 0x000a0000 May 31 14:18:11 myfw01s ppp: [wan_link0] MRU 1500 May 31 14:18:11 myfw01s ppp: [wan_link0] MAGICNUM a6abc118 May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: state change Ack-Sent --> Opened May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: auth: peer wants CHAP, I want nothing May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: LayerUp May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: rec'd Discard Request #31 (Opened) May 31 14:18:11 myfw01s ppp: [wan_link0] CHAP: rec'd CHALLENGE #1 len: 35 May 31 14:18:11 myfw01s ppp: [wan_link0] Name: "UMTS_CHAP_SRVR" May 31 14:18:11 myfw01s ppp: [wan_link0] CHAP: Using authname "user" May 31 14:18:11 myfw01s ppp: [wan_link0] CHAP: sending RESPONSE #1 len: 25 May 31 14:18:11 myfw01s ppp: [wan_link0] CHAP: rec'd SUCCESS #1 len: 4 May 31 14:18:11 myfw01s ppp: [wan_link0] LCP: authorization successful May 31 14:18:11 myfw01s ppp: [wan_link0] Link: Matched action 'bundle "wan" ""' May 31 14:18:11 myfw01s ppp: [wan_link0] Link: Join bundle "wan" May 31 14:18:11 myfw01s ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 28800 bps May 31 14:18:11 myfw01s ppp: [wan] IPCP: Open event May 31 14:18:11 myfw01s ppp: [wan] IPCP: state change Initial --> Starting May 31 14:18:11 myfw01s ppp: [wan] IPCP: LayerStart May 31 14:18:11 myfw01s ppp: [wan] IPV6CP: Open event May 31 14:18:11 myfw01s ppp: [wan] IPV6CP: state change Initial --> Starting May 31 14:18:11 myfw01s ppp: [wan] IPV6CP: LayerStart May 31 14:18:11 myfw01s ppp: [wan] IPCP: Up event May 31 14:18:11 myfw01s ppp: [wan] IPCP: state change Starting --> Req-Sent May 31 14:18:11 myfw01s ppp: [wan] IPCP: SendConfigReq #18 May 31 14:18:11 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:11 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:11 myfw01s ppp: [wan] PRIDNS 0.0.0.0 May 31 14:18:11 myfw01s ppp: [wan] SECDNS 0.0.0.0 May 31 14:18:11 myfw01s ppp: [wan] IPV6CP: Up event May 31 14:18:11 myfw01s ppp: [wan] IPV6CP: state change Starting --> Req-Sent May 31 14:18:11 myfw01s ppp: [wan] IPV6CP: SendConfigReq #21 May 31 14:18:12 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #18 (Req-Sent) May 31 14:18:12 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:12 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:12 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:12 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:12 myfw01s ppp: [wan] IPCP: SendConfigReq #19 May 31 14:18:12 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:12 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:12 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:12 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:13 myfw01s ppp: [wan] IPV6CP: SendConfigReq #22 May 31 14:18:13 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #19 (Req-Sent) May 31 14:18:13 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:13 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:13 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:13 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:13 myfw01s ppp: [wan] IPCP: SendConfigReq #20 May 31 14:18:13 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:13 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:13 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:13 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:14 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #20 (Req-Sent) May 31 14:18:14 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:14 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:14 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:14 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:14 myfw01s ppp: [wan] IPCP: SendConfigReq #21 May 31 14:18:14 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:14 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:14 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:14 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:15 myfw01s ppp: [wan] IPV6CP: SendConfigReq #23 May 31 14:18:15 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #21 (Req-Sent) May 31 14:18:15 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:15 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:15 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:15 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:15 myfw01s ppp: [wan] IPCP: SendConfigReq #22 May 31 14:18:15 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:15 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:15 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:15 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:16 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #22 (Req-Sent) May 31 14:18:16 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:16 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:16 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:16 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:16 myfw01s ppp: [wan] IPCP: SendConfigReq #23 May 31 14:18:16 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:16 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:16 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:16 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:17 myfw01s ppp: [wan] IPV6CP: SendConfigReq #24 May 31 14:18:17 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #23 (Req-Sent) May 31 14:18:17 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:17 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:17 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:17 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:17 myfw01s ppp: [wan] IPCP: SendConfigReq #24 May 31 14:18:17 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:17 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:17 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:17 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:18 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #24 (Req-Sent) May 31 14:18:18 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:18 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:18 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:18 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:18 myfw01s ppp: [wan] IPCP: SendConfigReq #25 May 31 14:18:18 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:18 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:18 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:18 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:19 myfw01s ppp: [wan] IPV6CP: SendConfigReq #25 May 31 14:18:19 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #25 (Req-Sent) May 31 14:18:19 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:19 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:19 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:19 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:19 myfw01s ppp: [wan] IPCP: SendConfigReq #26 May 31 14:18:19 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:19 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:19 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:19 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:20 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #26 (Req-Sent) May 31 14:18:20 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:20 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:20 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:20 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:20 myfw01s ppp: [wan] IPCP: SendConfigReq #27 May 31 14:18:20 myfw01s ppp: [wan] IPADDR 0.0.0.0 May 31 14:18:20 myfw01s ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 31 14:18:20 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:20 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:21 myfw01s ppp: [wan] IPV6CP: SendConfigReq #26 May 31 14:18:21 myfw01s ppp: [wan] IPCP: rec'd Configure Nak #27 (Req-Sent) May 31 14:18:21 myfw01s ppp: [wan] PRIDNS 10.11.12.13 May 31 14:18:21 myfw01s ppp: [wan] SECDNS 10.11.12.14 May 31 14:18:21 myfw01s ppp: [wan] PRINBNS 10.11.12.13 May 31 14:18:21 myfw01s ppp: [wan] SECNBNS 10.11.12.14 May 31 14:18:21 myfw01s ppp: [wan] IPCP: not converging May 31 14:18:21 myfw01s ppp: [wan] IPCP: parameter negotiation failed May 31 14:18:21 myfw01s ppp: [wan] IPCP: state change Req-Sent --> Stopped May 31 14:18:21 myfw01s ppp: [wan] IPCP: LayerFinish May 31 14:18:23 myfw01s ppp: [wan] IPV6CP: SendConfigReq #27 May 31 14:18:25 myfw01s ppp: [wan] IPV6CP: SendConfigReq #28 May 31 14:18:27 myfw01s ppp: [wan] IPV6CP: SendConfigReq #29 May 31 14:18:29 myfw01s ppp: [wan] IPV6CP: SendConfigReq #30 May 31 14:18:31 myfw01s ppp: [wan] IPV6CP: parameter negotiation failed May 31 14:18:31 myfw01s ppp: [wan] IPV6CP: state change Req-Sent --> Stopped May 31 14:18:31 myfw01s ppp: [wan] IPV6CP: LayerFinish May 31 14:18:31 myfw01s ppp: [wan] Bundle: No NCPs left. Closing links... May 31 14:18:31 myfw01s ppp: [wan] Bundle: closing link "wan_link0"... May 31 14:18:31 myfw01s ppp: [wan_link0] Link: CLOSE event May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: Close event May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: state change Opened --> Closing May 31 14:18:31 myfw01s ppp: [wan_link0] Link: Leave bundle "wan" May 31 14:18:31 myfw01s ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 31 14:18:31 myfw01s ppp: [wan] IPCP: Close event May 31 14:18:31 myfw01s ppp: [wan] IPCP: state change Stopped --> Closed May 31 14:18:31 myfw01s ppp: [wan] IPV6CP: Close event May 31 14:18:31 myfw01s ppp: [wan] IPV6CP: state change Stopped --> Closed May 31 14:18:31 myfw01s ppp: [wan] IPCP: Down event May 31 14:18:31 myfw01s ppp: [wan] IPCP: state change Closed --> Initial May 31 14:18:31 myfw01s ppp: [wan] IPV6CP: Down event May 31 14:18:31 myfw01s ppp: [wan] IPV6CP: state change Closed --> Initial May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: SendTerminateReq #6 May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: LayerDown May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: rec'd Terminate Ack #6 (Closing) May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: state change Closing --> Closed May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: LayerFinish May 31 14:18:31 myfw01s ppp: [wan_link0] Link: DOWN event May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: Down event May 31 14:18:31 myfw01s ppp: [wan_link0] LCP: state change Closed --> Initial May 31 14:19:06 myfw01s kernel: ovpnc1: link state changed to DOWN May 31 14:19:06 myfw01s check_reload_status: Reloading filter
-
Massively late reply…...
Still looks like they just don't send you an IP address so it just keeps asking.
No clue what that could be be. :-\
Steve