[2.3.x] DPINGER WAN_PPPoE sendto error: 65 (no WAN access)
-
Try both, same problem. I think it's 2.3.x related, same config on 2.2.x works perfectly.
-
UPDATE: i try 2.3.1 installation on another my old firewall, an Alix motherboard. Fresh installation of 2Gb Nano 2.3.1 version, with PPPoE on WAN with 100Mb/s Telecom fiber connection. Same DPINGER error 65, with firewall and LAN PC unable to ping external IP. External traffic impossibile.
-
Anyone with the same problem with PPPoE and 2.3.x?
-
Yup,
After the upgrade to 2.3.1 no client had access to the internet, reboot didn't help, at least not the 2 times I tried that.
My IPSEC VPNs were up normally.
From pfsense itself I couldn't ping on hostnames, so DNS didn't work, I could however ping an IP.
From the clients I couldn't ping the same IP…..Disconnect and reconnect the PPPoE solved it instantly. Haven't tried a new reboot since then.
There is definitly something going on regarding PPPoE in 2.3.1
-
Disconnect and reconnect the PPPoE solved it instantly. Haven't tried a new reboot since then.
Not for me. Try to disconnect and reconnect, same problem. PPPoE with no internet access. :(
-
No problem in my system with 2.3.1.
-
UPDATE: backup my config from pfSense 2.2.6, then start a fresh installation on the same hardware of 2.3.1. After that, i restore config and restart pfSense. After reboot, WAN PPPoE was down, so i tried to disconnect/connect WAN interface. After 5 attempts, WAN PPPoE interface goes up. :D
But there is a problem: if i reboot pfSense, WAN PPPoE interface doesn't start automatically, and i need to disconnect/reconnet WAN interface al least 4/5 times. Instead, if WAN interface has fixed or static IP (no PPPoe), everything works fine.
-
dpinger logging that is a symptom of the problem, which seems to be that your PPPoE isn't connecting. What do the PPP logs show when it's not working?
-
Hi CMB,
thanks for your reply. :)Here is PPP logs:
May 23 22:11:31 ppp [wan] IPV6CP: LayerFinish May 23 22:11:31 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:11:28 ppp [wan] IPV6CP: LayerDown May 23 22:11:28 ppp [wan] IPV6CP: SendTerminateAck #6 May 23 22:11:28 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:11:28 ppp [wan] IPV6CP: rec'd Terminate Request #212 (Opened) May 23 22:11:28 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:11:28 ppp [wan] IPV6CP: LayerUp May 23 22:11:28 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:11:28 ppp [wan] IPV6CP: SendConfigAck #211 May 23 22:11:28 ppp [wan] IPV6CP: rec'd Configure Request #211 (Ack-Rcvd) May 23 22:11:28 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:11:28 ppp [wan] IPV6CP: rec'd Configure Ack #5 (Req-Sent) May 23 22:11:28 ppp [wan] IPV6CP: SendConfigReq #5 May 23 22:11:26 ppp [wan] IPV6CP: SendTerminateAck #4 May 23 22:11:26 ppp [wan] IPV6CP: state change Ack-Sent --> Req-Sent May 23 22:11:26 ppp [wan] IPV6CP: rec'd Terminate Request #1 (Ack-Sent) May 23 22:11:26 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Sent May 23 22:11:26 ppp [wan] IPV6CP: SendConfigAck #0 May 23 22:11:26 ppp [wan] IPV6CP: rec'd Configure Request #0 (Req-Sent) May 23 22:11:26 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:11:26 ppp [wan] IFACE: Up event May 23 22:11:26 ppp [wan] 87.21.211.177 -> 192.168.100.1 May 23 22:11:26 ppp [wan] IPCP: LayerUp May 23 22:11:26 ppp [wan] IPCP: state change Ack-Sent --> Opened May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177 May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) May 23 22:11:26 ppp [wan] IPCP: state change Req-Sent --> Ack-Sent May 23 22:11:26 ppp [wan] IPADDR 192.168.100.1 May 23 22:11:26 ppp [wan] IPCP: SendConfigAck #181 May 23 22:11:26 ppp [wan] 192.168.100.1 is OK May 23 22:11:26 ppp [wan] IPADDR 192.168.100.1 May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Request #181 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: SendTerminateAck #3 May 23 22:11:26 ppp [wan] IPV6CP: rec'd Terminate Request #255 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:11:26 ppp [wan] IPV6CP: state change Ack-Rcvd --> Req-Sent May 23 22:11:26 ppp [wan] IPV6CP: rec'd Terminate Request #254 (Ack-Rcvd) May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177 May 23 22:11:26 ppp [wan] IPCP: SendConfigReq #3 May 23 22:11:26 ppp [wan] 87.21.211.177 is OK May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177 May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:11:26 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:11:26 ppp [wan] IPADDR 0.0.0.0 May 23 22:11:26 ppp [wan] IPCP: SendConfigReq #2 May 23 22:11:26 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:11:26 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:11:26 ppp [wan] IPV6CP: Up event May 23 22:11:26 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:11:26 ppp [wan] IPADDR 0.0.0.0 May 23 22:11:26 ppp [wan] IPCP: SendConfigReq #1 May 23 22:11:26 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:11:26 ppp [wan] IPCP: Up event May 23 22:11:26 ppp [wan] IPV6CP: LayerStart May 23 22:11:26 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:11:26 ppp [wan] IPV6CP: Open event May 23 22:11:26 ppp [wan] IPCP: LayerStart May 23 22:11:26 ppp [wan] IPCP: state change Initial --> Starting May 23 22:11:26 ppp [wan] IPCP: Open event May 23 22:11:26 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:11:26 ppp [wan_link0] Link: Join bundle "wan" May 23 22:11:26 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:11:26 ppp [wan_link0] LCP: authorization successful May 23 22:11:26 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:11:26 ppp [wan_link0] LCP: LayerUp May 23 22:11:26 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:11:26 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:11:26 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:11:26 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:11:26 ppp [wan_link0] MAGICNUM 0xcef11f0e May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] PROTOCOMP May 23 22:11:26 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:11:26 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:11:26 ppp [wan_link0] MAGICNUM 0x536a27fa May 23 22:11:26 ppp [wan_link0] AUTHPROTO PAP May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] LCP: SendConfigAck #56 May 23 22:11:26 ppp [wan_link0] MAGICNUM 0x536a27fa May 23 22:11:26 ppp [wan_link0] AUTHPROTO PAP May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] LCP: rec'd Configure Request #56 (Req-Sent) May 23 22:11:26 ppp [wan_link0] MAGICNUM 0xcef11f0e May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] PROTOCOMP May 23 22:11:26 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:11:26 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:11:26 ppp [wan_link0] LCP: Up event May 23 22:11:26 ppp [wan_link0] Link: UP event May 23 22:11:26 ppp [wan_link0] PPPoE: connection successful May 23 22:11:26 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:11:25 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:11:25 ppp [wan_link0] LCP: LayerStart May 23 22:11:25 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:11:25 ppp [wan_link0] LCP: Open event May 23 22:11:25 ppp [wan_link0] Link: OPEN event May 23 22:11:25 ppp [wan] Bundle: Interface ng0 created May 23 22:11:25 ppp web: web is not running May 23 22:11:25 ppp process 84326 terminated May 23 22:11:25 ppp [wan_link0] Link: Shutdown May 23 22:11:25 ppp [wan] Bundle: Shutdown May 23 22:11:24 ppp waiting for process 84326 to die... May 23 22:11:24 ppp process 12005 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:11:24 ppp Multi-link PPP daemon for FreeBSD May 23 22:11:23 ppp [wan_link0] LCP: Close event May 23 22:11:23 ppp [wan_link0] Link: CLOSE event May 23 22:11:23 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:11:23 ppp [wan_link0] LCP: LayerFinish May 23 22:11:23 ppp [wan_link0] LCP: Down event May 23 22:11:23 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:11:23 ppp [wan_link0] LCP: Close event May 23 22:11:23 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:11:23 ppp [wan_link0] Link: DOWN event May 23 22:11:23 ppp [wan_link0] PPPoE: connection closed May 23 22:11:23 ppp [wan_link0] LCP: LayerDown May 23 22:11:23 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:11:23 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:11:23 ppp [wan] IPV6CP: Down event May 23 22:11:23 ppp [wan] IPCP: state change Closed --> Initial May 23 22:11:23 ppp [wan] IPCP: Down event May 23 22:11:23 ppp [wan] IPV6CP: Close event May 23 22:11:23 ppp [wan] IPCP: Close event May 23 22:11:23 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:11:23 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:11:23 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:11:23 ppp [wan_link0] LCP: rec'd Terminate Request #24 (Opened) May 23 22:11:23 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:11:23 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:11:23 ppp [wan] IPCP: LayerFinish May 23 22:11:23 ppp [wan] IPCP: state change Closing --> Closed May 23 22:11:23 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:11:23 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:11:23 ppp [wan] IPV6CP: Close event May 23 22:11:23 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:11:23 ppp [wan] IFACE: Down event May 23 22:11:22 ppp [wan] IPCP: LayerDown May 23 22:11:22 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:11:22 ppp [wan] IPCP: state change Opened --> Closing May 23 22:11:22 ppp [wan] IPCP: Close event May 23 22:11:22 ppp [wan] IFACE: Close event May 23 22:11:22 ppp caught fatal signal TERM May 23 22:09:14 ppp [wan] IPV6CP: LayerFinish May 23 22:09:14 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:09:12 ppp [wan] IPV6CP: LayerDown May 23 22:09:12 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:09:12 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:09:12 ppp [wan] IPV6CP: rec'd Terminate Request #184 (Opened) May 23 22:09:12 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:09:12 ppp [wan] IPV6CP: LayerUp May 23 22:09:12 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:09:12 ppp [wan] IPV6CP: SendConfigAck #183 May 23 22:09:12 ppp [wan] IPV6CP: rec'd Configure Request #183 (Ack-Rcvd) May 23 22:09:12 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:09:12 ppp [wan] IFACE: Up event May 23 22:09:12 ppp [wan] 82.53.152.239 -> 192.168.100.1 May 23 22:09:12 ppp [wan] IPCP: LayerUp May 23 22:09:12 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:09:12 ppp [wan] IPADDR 192.168.100.1 May 23 22:09:12 ppp [wan] IPCP: SendConfigAck #247 May 23 22:09:12 ppp [wan] 192.168.100.1 is OK May 23 22:09:12 ppp [wan] IPADDR 192.168.100.1 May 23 22:09:12 ppp [wan] IPCP: rec'd Configure Request #247 (Ack-Rcvd) May 23 22:09:12 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:09:12 ppp [wan] IPADDR 82.53.152.239 May 23 22:09:12 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:09:12 ppp [wan] IPADDR 82.53.152.239 May 23 22:09:12 ppp [wan] IPCP: SendConfigReq #3 May 23 22:09:12 ppp [wan] 82.53.152.239 is OK May 23 22:09:12 ppp [wan] IPADDR 82.53.152.239 May 23 22:09:12 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:09:11 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:09:11 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:09:11 ppp [wan] IPADDR 0.0.0.0 May 23 22:09:11 ppp [wan] IPCP: SendConfigReq #2 May 23 22:09:11 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:09:11 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:09:11 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:09:11 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:09:11 ppp [wan] IPV6CP: Up event May 23 22:09:11 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:09:11 ppp [wan] IPADDR 0.0.0.0 May 23 22:09:11 ppp [wan] IPCP: SendConfigReq #1 May 23 22:09:11 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:09:11 ppp [wan] IPCP: Up event May 23 22:09:11 ppp [wan] IPV6CP: LayerStart May 23 22:09:11 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:09:11 ppp [wan] IPV6CP: Open event May 23 22:09:11 ppp [wan] IPCP: LayerStart May 23 22:09:11 ppp [wan] IPCP: state change Initial --> Starting May 23 22:09:11 ppp [wan] IPCP: Open event May 23 22:09:11 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:09:11 ppp [wan_link0] Link: Join bundle "wan" May 23 22:09:11 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:09:11 ppp [wan_link0] LCP: authorization successful May 23 22:09:11 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:09:11 ppp [wan_link0] LCP: LayerUp May 23 22:09:11 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:09:11 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:09:11 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:09:11 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x79b7508e May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] PROTOCOMP May 23 22:09:11 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:09:11 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x3406c6c8 May 23 22:09:11 ppp [wan_link0] AUTHPROTO PAP May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] LCP: SendConfigAck #23 May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x3406c6c8 May 23 22:09:11 ppp [wan_link0] AUTHPROTO PAP May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] LCP: rec'd Configure Request #23 (Req-Sent) May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x79b7508e May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] PROTOCOMP May 23 22:09:11 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:09:11 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:09:11 ppp [wan_link0] LCP: Up event May 23 22:09:11 ppp [wan_link0] Link: UP event May 23 22:09:11 ppp [wan_link0] PPPoE: connection successful May 23 22:09:11 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:09:11 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:09:11 ppp [wan_link0] LCP: LayerStart May 23 22:09:11 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:09:11 ppp [wan_link0] LCP: Open event May 23 22:09:11 ppp [wan_link0] Link: OPEN event May 23 22:09:11 ppp [wan] Bundle: Interface ng0 created May 23 22:09:11 ppp web: web is not running May 23 22:09:10 ppp process 91397 terminated May 23 22:09:10 ppp [wan_link0] Link: Shutdown May 23 22:09:10 ppp [wan] Bundle: Shutdown May 23 22:09:10 ppp waiting for process 91397 to die... May 23 22:09:10 ppp process 84326 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:09:10 ppp Multi-link PPP daemon for FreeBSD May 23 22:09:08 ppp [wan_link0] LCP: Close event May 23 22:09:08 ppp [wan_link0] Link: CLOSE event May 23 22:09:08 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:09:08 ppp [wan_link0] LCP: LayerFinish May 23 22:09:08 ppp [wan_link0] LCP: Down event May 23 22:09:08 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:09:08 ppp [wan_link0] LCP: Close event May 23 22:09:08 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:09:08 ppp [wan_link0] Link: DOWN event May 23 22:09:08 ppp [wan_link0] PPPoE: connection closed May 23 22:09:08 ppp [wan_link0] LCP: LayerDown May 23 22:09:08 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:09:08 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:09:08 ppp [wan] IPV6CP: Down event May 23 22:09:08 ppp [wan] IPCP: state change Closed --> Initial May 23 22:09:08 ppp [wan] IPCP: Down event May 23 22:09:08 ppp [wan] IPV6CP: Close event May 23 22:09:08 ppp [wan] IPCP: Close event May 23 22:09:08 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:09:08 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:09:08 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:09:08 ppp [wan_link0] LCP: rec'd Terminate Request #148 (Opened) May 23 22:09:08 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:09:08 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:09:08 ppp [wan] IPCP: LayerFinish May 23 22:09:08 ppp [wan] IPCP: state change Closing --> Closed May 23 22:09:08 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:09:08 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:09:08 ppp [wan] IPV6CP: Close event May 23 22:09:08 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:09:08 ppp [wan] IFACE: Down event May 23 22:09:08 ppp [wan] IPCP: LayerDown May 23 22:09:08 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:09:08 ppp [wan] IPCP: state change Opened --> Closing May 23 22:09:08 ppp [wan] IPCP: Close event May 23 22:09:08 ppp [wan] IFACE: Close event May 23 22:09:08 ppp caught fatal signal TERM May 23 22:07:06 ppp [wan] IPV6CP: LayerFinish May 23 22:07:06 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:07:04 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:07:04 ppp [wan] IFACE: Up event May 23 22:07:04 ppp [wan] 87.1.223.81 -> 192.168.100.1 May 23 22:07:04 ppp [wan] IPCP: LayerUp May 23 22:07:04 ppp [wan] IPCP: state change Ack-Sent --> Opened May 23 22:07:04 ppp [wan] IPADDR 87.1.223.81 May 23 22:07:04 ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) May 23 22:07:04 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:07:04 ppp [wan] IFACE: Down event May 23 22:07:03 ppp [wan] IPV6CP: LayerDown May 23 22:07:03 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:07:03 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:07:03 ppp [wan] IPV6CP: rec'd Terminate Request #193 (Opened) May 23 22:07:03 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:07:03 ppp [wan] IFACE: Up event May 23 22:07:03 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:07:03 ppp [wan] IPV6CP: LayerUp May 23 22:07:03 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:07:03 ppp [wan] IPV6CP: SendConfigAck #192 May 23 22:07:03 ppp [wan] IPV6CP: rec'd Configure Request #192 (Ack-Rcvd) May 23 22:07:03 ppp [wan] IPADDR 87.1.223.81 May 23 22:07:03 ppp [wan] IPCP: SendConfigReq #3 May 23 22:07:03 ppp [wan] 87.1.223.81 is OK May 23 22:07:03 ppp [wan] IPADDR 87.1.223.81 May 23 22:07:03 ppp [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent) May 23 22:07:03 ppp [wan] IPCP: state change Req-Sent --> Ack-Sent May 23 22:07:03 ppp [wan] IPADDR 192.168.100.1 May 23 22:07:03 ppp [wan] IPCP: SendConfigAck #172 May 23 22:07:03 ppp [wan] 192.168.100.1 is OK May 23 22:07:03 ppp [wan] IPADDR 192.168.100.1 May 23 22:07:03 ppp [wan] IPCP: rec'd Configure Request #172 (Req-Sent) May 23 22:07:03 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:07:03 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:07:03 ppp [wan] IPADDR 0.0.0.0 May 23 22:07:03 ppp [wan] IPCP: SendConfigReq #2 May 23 22:07:03 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:07:03 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:07:03 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:07:03 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:07:03 ppp [wan] IPV6CP: Up event May 23 22:07:03 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:07:03 ppp [wan] IPADDR 0.0.0.0 May 23 22:07:03 ppp [wan] IPCP: SendConfigReq #1 May 23 22:07:03 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:07:03 ppp [wan] IPCP: Up event May 23 22:07:03 ppp [wan] IPV6CP: LayerStart May 23 22:07:03 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:07:03 ppp [wan] IPV6CP: Open event May 23 22:07:03 ppp [wan] IPCP: LayerStart May 23 22:07:03 ppp [wan] IPCP: state change Initial --> Starting May 23 22:07:03 ppp [wan] IPCP: Open event May 23 22:07:03 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:07:03 ppp [wan_link0] Link: Join bundle "wan" May 23 22:07:03 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:07:03 ppp [wan_link0] LCP: authorization successful May 23 22:07:03 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:07:03 ppp [wan_link0] LCP: LayerUp May 23 22:07:03 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:07:03 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:07:03 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:07:03 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x5cce6d32 May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] PROTOCOMP May 23 22:07:03 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:07:03 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x30b57178 May 23 22:07:03 ppp [wan_link0] AUTHPROTO PAP May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] LCP: SendConfigAck #147 May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x30b57178 May 23 22:07:03 ppp [wan_link0] AUTHPROTO PAP May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] LCP: rec'd Configure Request #147 (Req-Sent) May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x5cce6d32 May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] PROTOCOMP May 23 22:07:03 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:07:03 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:07:03 ppp [wan_link0] LCP: Up event May 23 22:07:03 ppp [wan_link0] Link: UP event May 23 22:07:03 ppp [wan_link0] PPPoE: connection successful May 23 22:07:03 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:07:03 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:07:03 ppp [wan_link0] LCP: LayerStart May 23 22:07:03 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:07:03 ppp [wan_link0] LCP: Open event May 23 22:07:03 ppp [wan_link0] Link: OPEN event May 23 22:07:03 ppp [wan] Bundle: Interface ng0 created May 23 22:07:03 ppp web: web is not running May 23 22:07:03 ppp process 91397 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:07:03 ppp Multi-link PPP daemon for FreeBSD May 23 22:06:49 ppp process 8514 terminated May 23 22:06:49 ppp [wan_link0] Link: Shutdown May 23 22:06:49 ppp [wan] Bundle: Shutdown May 23 22:06:47 ppp [wan_link0] LCP: Close event May 23 22:06:47 ppp [wan_link0] Link: CLOSE event May 23 22:06:47 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:06:47 ppp [wan_link0] LCP: LayerFinish May 23 22:06:47 ppp [wan_link0] LCP: Down event May 23 22:06:47 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:06:47 ppp [wan_link0] LCP: Close event May 23 22:06:47 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:06:47 ppp [wan_link0] Link: DOWN event May 23 22:06:47 ppp [wan_link0] PPPoE: connection closed May 23 22:06:47 ppp [wan_link0] LCP: LayerDown May 23 22:06:47 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:06:47 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:06:47 ppp [wan] IPV6CP: Down event May 23 22:06:47 ppp [wan] IPCP: state change Closed --> Initial May 23 22:06:47 ppp [wan] IPCP: Down event May 23 22:06:47 ppp [wan] IPV6CP: Close event May 23 22:06:47 ppp [wan] IPCP: Close event May 23 22:06:47 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:06:47 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:06:47 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:06:47 ppp [wan_link0] LCP: rec'd Terminate Request #204 (Opened) May 23 22:06:47 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:06:47 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:06:47 ppp [wan] IPCP: LayerFinish May 23 22:06:47 ppp [wan] IPCP: state change Closing --> Closed May 23 22:06:47 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:06:47 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:06:47 ppp [wan] IPV6CP: Close event May 23 22:06:47 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:06:47 ppp [wan] IFACE: Down event May 23 22:06:46 ppp [wan] IPCP: LayerDown May 23 22:06:46 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:06:46 ppp [wan] IPCP: state change Opened --> Closing May 23 22:06:46 ppp [wan] IPCP: Close event May 23 22:06:46 ppp [wan] IFACE: Close event May 23 22:06:46 ppp caught fatal signal TERM May 23 22:05:05 ppp [wan] IPV6CP: LayerFinish May 23 22:05:05 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:05:03 ppp [wan] IPV6CP: LayerDown May 23 22:05:03 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:05:03 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:05:03 ppp [wan] IPV6CP: rec'd Terminate Request #82 (Opened) May 23 22:05:02 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:05:02 ppp [wan] IPV6CP: LayerUp May 23 22:05:02 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:05:02 ppp [wan] IPV6CP: SendConfigAck #81 May 23 22:05:02 ppp [wan] IPV6CP: rec'd Configure Request #81 (Ack-Rcvd) May 23 22:05:02 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:05:02 ppp [wan] IFACE: Up event May 23 22:05:02 ppp [wan] 82.51.149.195 -> 192.168.100.1 May 23 22:05:02 ppp [wan] IPCP: LayerUp May 23 22:05:02 ppp [wan] IPCP: state change Ack-Sent --> Opened May 23 22:05:02 ppp [wan] IPADDR 82.51.149.195 May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) May 23 22:05:02 ppp [wan] IPCP: state change Req-Sent --> Ack-Sent May 23 22:05:02 ppp [wan] IPADDR 192.168.100.1 May 23 22:05:02 ppp [wan] IPCP: SendConfigAck #15 May 23 22:05:02 ppp [wan] 192.168.100.1 is OK May 23 22:05:02 ppp [wan] IPADDR 192.168.100.1 May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Request #15 (Req-Sent) May 23 22:05:02 ppp [wan] IPADDR 82.51.149.195 May 23 22:05:02 ppp [wan] IPCP: SendConfigReq #3 May 23 22:05:02 ppp [wan] 82.51.149.195 is OK May 23 22:05:02 ppp [wan] IPADDR 82.51.149.195 May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:05:02 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:05:02 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:05:02 ppp [wan] IPADDR 0.0.0.0 May 23 22:05:02 ppp [wan] IPCP: SendConfigReq #2 May 23 22:05:02 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:05:02 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:05:02 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:05:02 ppp [wan] IPV6CP: Up event May 23 22:05:02 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:05:02 ppp [wan] IPADDR 0.0.0.0 May 23 22:05:02 ppp [wan] IPCP: SendConfigReq #1 May 23 22:05:02 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:05:02 ppp [wan] IPCP: Up event May 23 22:05:02 ppp [wan] IPV6CP: LayerStart May 23 22:05:02 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:05:02 ppp [wan] IPV6CP: Open event May 23 22:05:02 ppp [wan] IPCP: LayerStart May 23 22:05:02 ppp [wan] IPCP: state change Initial --> Starting May 23 22:05:02 ppp [wan] IPCP: Open event May 23 22:05:02 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:05:02 ppp [wan_link0] Link: Join bundle "wan" May 23 22:05:02 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:05:02 ppp [wan_link0] LCP: authorization successful May 23 22:05:02 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:05:02 ppp [wan_link0] LCP: LayerUp May 23 22:05:02 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:05:02 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:05:02 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:05:02 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x57f267c0 May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] PROTOCOMP May 23 22:05:02 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:05:02 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x2e5d1f70 May 23 22:05:02 ppp [wan_link0] AUTHPROTO PAP May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] LCP: SendConfigAck #203 May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x2e5d1f70 May 23 22:05:02 ppp [wan_link0] AUTHPROTO PAP May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] LCP: rec'd Configure Request #203 (Req-Sent) May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x57f267c0 May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] PROTOCOMP May 23 22:05:02 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:05:02 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:05:02 ppp [wan_link0] LCP: Up event May 23 22:05:02 ppp [wan_link0] Link: UP event May 23 22:05:02 ppp [wan_link0] PPPoE: connection successful May 23 22:05:02 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:05:02 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:05:02 ppp [wan_link0] LCP: LayerStart May 23 22:05:02 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:05:02 ppp [wan_link0] LCP: Open event May 23 22:05:02 ppp [wan_link0] Link: OPEN event May 23 22:05:02 ppp [wan] Bundle: Interface ng0 created May 23 22:05:02 ppp web: web is not running May 23 22:05:02 ppp process 8514 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:05:02 ppp Multi-link PPP daemon for FreeBSD May 23 22:04:54 ppp process 67736 terminated May 23 22:04:54 ppp [wan_link0] Link: Shutdown May 23 22:04:54 ppp [wan] Bundle: Shutdown May 23 22:04:52 ppp [wan_link0] LCP: Close event May 23 22:04:52 ppp [wan_link0] Link: CLOSE event May 23 22:04:52 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:04:52 ppp [wan_link0] LCP: LayerFinish May 23 22:04:52 ppp [wan_link0] LCP: Down event May 23 22:04:52 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:04:52 ppp [wan_link0] LCP: Close event May 23 22:04:52 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:04:52 ppp [wan_link0] Link: DOWN event May 23 22:04:52 ppp [wan_link0] PPPoE: connection closed May 23 22:04:52 ppp [wan_link0] LCP: LayerDown May 23 22:04:52 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:04:52 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:04:52 ppp [wan] IPV6CP: Down event May 23 22:04:52 ppp [wan] IPCP: state change Closed --> Initial May 23 22:04:52 ppp [wan] IPCP: Down event May 23 22:04:52 ppp [wan] IPV6CP: Close event May 23 22:04:52 ppp [wan] IPCP: Close event May 23 22:04:52 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:04:52 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:04:52 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:04:52 ppp [wan_link0] LCP: rec'd Terminate Request #148 (Opened) May 23 22:04:52 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:04:52 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:04:52 ppp [wan] IPCP: LayerFinish May 23 22:04:52 ppp [wan] IPCP: state change Closing --> Closed May 23 22:04:52 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:04:52 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:04:52 ppp [wan] IPV6CP: Close event May 23 22:04:52 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:04:52 ppp [wan] IFACE: Down event May 23 22:04:52 ppp [wan] IPCP: LayerDown May 23 22:04:52 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:04:52 ppp [wan] IPCP: state change Opened --> Closing May 23 22:04:52 ppp [wan] IPCP: Close event May 23 22:04:52 ppp [wan] IFACE: Close event May 23 22:04:52 ppp caught fatal signal TERM May 23 22:04:18 ppp [wan] IPV6CP: LayerFinish May 23 22:04:18 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:04:15 ppp [wan] IPV6CP: LayerDown May 23 22:04:15 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:04:15 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:04:15 ppp [wan] IPV6CP: rec'd Terminate Request #174 (Opened) May 23 22:04:15 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:04:15 ppp [wan] IPV6CP: LayerUp May 23 22:04:15 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:04:15 ppp [wan] IPV6CP: SendConfigAck #173 May 23 22:04:15 ppp [wan] IPV6CP: rec'd Configure Request #173 (Ack-Rcvd) May 23 22:04:15 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:04:15 ppp [wan] IFACE: Up event May 23 22:04:15 ppp [wan] 82.51.146.47 -> 192.168.100.1 May 23 22:04:15 ppp [wan] IPCP: LayerUp May 23 22:04:15 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:04:15 ppp [wan] IPADDR 192.168.100.1 May 23 22:04:15 ppp [wan] IPCP: SendConfigAck #100 May 23 22:04:15 ppp [wan] 192.168.100.1 is OK May 23 22:04:15 ppp [wan] IPADDR 192.168.100.1 May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Request #100 (Ack-Rcvd) May 23 22:04:15 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:04:15 ppp [wan] IPADDR 82.51.146.47 May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:04:15 ppp [wan] IPADDR 82.51.146.47 May 23 22:04:15 ppp [wan] IPCP: SendConfigReq #3 May 23 22:04:15 ppp [wan] 82.51.146.47 is OK May 23 22:04:15 ppp [wan] IPADDR 82.51.146.47 May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:04:15 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:04:15 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:04:15 ppp [wan] IPADDR 0.0.0.0 May 23 22:04:15 ppp [wan] IPCP: SendConfigReq #2 May 23 22:04:15 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:04:15 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:04:15 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:04:15 ppp [wan] IPV6CP: Up event May 23 22:04:15 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:04:15 ppp [wan] IPADDR 0.0.0.0 May 23 22:04:15 ppp [wan] IPCP: SendConfigReq #1 May 23 22:04:15 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:04:15 ppp [wan] IPCP: Up event May 23 22:04:15 ppp [wan] IPV6CP: LayerStart May 23 22:04:15 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:04:15 ppp [wan] IPV6CP: Open event May 23 22:04:15 ppp [wan] IPCP: LayerStart May 23 22:04:15 ppp [wan] IPCP: state change Initial --> Starting May 23 22:04:15 ppp [wan] IPCP: Open event May 23 22:04:15 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:04:15 ppp [wan_link0] Link: Join bundle "wan" May 23 22:04:15 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:04:15 ppp [wan_link0] LCP: authorization successful May 23 22:04:15 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:04:15 ppp [wan_link0] LCP: LayerUp May 23 22:04:15 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:04:15 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:04:15 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:04:15 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7a955848 May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] PROTOCOMP May 23 22:04:15 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:04:15 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7340e4e0 May 23 22:04:15 ppp [wan_link0] AUTHPROTO PAP May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] LCP: SendConfigAck #147 May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7340e4e0 May 23 22:04:15 ppp [wan_link0] AUTHPROTO PAP May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] LCP: rec'd Configure Request #147 (Req-Sent) May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7a955848 May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] PROTOCOMP May 23 22:04:15 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:04:15 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:04:15 ppp [wan_link0] LCP: Up event May 23 22:04:15 ppp [wan_link0] Link: UP event May 23 22:04:15 ppp [wan_link0] PPPoE: connection successful May 23 22:04:15 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:04:15 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:04:15 ppp [wan_link0] LCP: LayerStart May 23 22:04:15 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:04:15 ppp [wan_link0] LCP: Open event May 23 22:04:15 ppp [wan_link0] Link: OPEN event May 23 22:04:15 ppp [wan] Bundle: Interface ng0 created May 23 22:04:15 ppp web: web is not running May 23 22:04:15 ppp process 67736 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:04:15 ppp Multi-link PPP daemon for FreeBSD May 23 22:04:13 ppp process 19089 terminated May 23 22:04:13 ppp [wan_link0] Link: Shutdown May 23 22:04:13 ppp [wan] Bundle: Shutdown May 23 22:04:11 ppp [wan_link0] LCP: Close event May 23 22:04:11 ppp [wan_link0] Link: CLOSE event May 23 22:04:11 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:04:11 ppp [wan_link0] LCP: LayerFinish May 23 22:04:11 ppp [wan_link0] LCP: Down event May 23 22:04:11 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:04:11 ppp [wan_link0] LCP: Close event May 23 22:04:11 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:04:11 ppp [wan_link0] Link: DOWN event May 23 22:04:11 ppp [wan_link0] PPPoE: connection closed May 23 22:04:11 ppp [wan_link0] LCP: LayerDown May 23 22:04:11 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:04:11 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:04:11 ppp [wan] IPV6CP: Down event May 23 22:04:11 ppp [wan] IPCP: state change Closed --> Initial May 23 22:04:11 ppp [wan] IPCP: Down event May 23 22:04:11 ppp [wan] IPV6CP: Close event May 23 22:04:11 ppp [wan] IPCP: Close event May 23 22:04:11 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:04:11 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:04:11 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:04:11 ppp [wan_link0] LCP: rec'd Terminate Request #165 (Opened) May 23 22:04:11 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:04:11 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:04:11 ppp [wan] IPCP: LayerFinish May 23 22:04:11 ppp [wan] IPCP: state change Closing --> Closed May 23 22:04:11 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:04:11 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:04:11 ppp [wan] IPV6CP: Close event May 23 22:04:11 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:04:11 ppp [wan] IFACE: Down event May 23 22:04:11 ppp [wan] IPCP: LayerDown May 23 22:04:11 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:04:11 ppp [wan] IPCP: state change Opened --> Closing May 23 22:04:11 ppp [wan] IPCP: Close event May 23 22:04:11 ppp [wan] IFACE: Close event May 23 22:04:11 ppp caught fatal signal TERM May 23 22:02:10 ppp [wan] IPV6CP: LayerFinish May 23 22:02:10 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:02:08 ppp [wan] IPV6CP: LayerDown May 23 22:02:08 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:02:08 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:02:08 ppp [wan] IPV6CP: rec'd Terminate Request #223 (Opened) May 23 22:02:08 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:02:08 ppp [wan] IPV6CP: LayerUp May 23 22:02:08 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:02:08 ppp [wan] IPV6CP: SendConfigAck #222 May 23 22:02:08 ppp [wan] IPV6CP: rec'd Configure Request #222 (Ack-Rcvd) May 23 22:02:08 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:02:08 ppp [wan] IFACE: Up event May 23 22:02:08 ppp [wan] 87.6.212.160 -> 192.168.100.1 May 23 22:02:08 ppp [wan] IPCP: LayerUp May 23 22:02:08 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:02:08 ppp [wan] IPADDR 192.168.100.1 May 23 22:02:08 ppp [wan] IPCP: SendConfigAck #157 May 23 22:02:08 ppp [wan] 192.168.100.1 is OK May 23 22:02:08 ppp [wan] IPADDR 192.168.100.1 May 23 22:02:08 ppp [wan] IPCP: rec'd Configure Request #157 (Ack-Rcvd) May 23 22:02:07 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:02:07 ppp [wan] IPADDR 87.6.212.160 May 23 22:02:07 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:02:07 ppp [wan] IPADDR 87.6.212.160 May 23 22:02:07 ppp [wan] IPCP: SendConfigReq #3 May 23 22:02:07 ppp [wan] 87.6.212.160 is OK May 23 22:02:07 ppp [wan] IPADDR 87.6.212.160 May 23 22:02:07 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:02:07 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:02:07 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:02:07 ppp [wan] IPADDR 0.0.0.0 May 23 22:02:07 ppp [wan] IPCP: SendConfigReq #2 May 23 22:02:07 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:02:07 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:02:07 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:02:07 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:02:07 ppp [wan] IPV6CP: Up event May 23 22:02:07 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:02:07 ppp [wan] IPADDR 0.0.0.0 May 23 22:02:07 ppp [wan] IPCP: SendConfigReq #1 May 23 22:02:07 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:02:07 ppp [wan] IPCP: Up event May 23 22:02:07 ppp [wan] IPV6CP: LayerStart May 23 22:02:07 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:02:07 ppp [wan] IPV6CP: Open event May 23 22:02:07 ppp [wan] IPCP: LayerStart May 23 22:02:07 ppp [wan] IPCP: state change Initial --> Starting May 23 22:02:07 ppp [wan] IPCP: Open event May 23 22:02:07 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:02:07 ppp [wan_link0] Link: Join bundle "wan" May 23 22:02:07 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:02:07 ppp [wan_link0] LCP: authorization successful May 23 22:02:07 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:02:07 ppp [wan_link0] LCP: LayerUp May 23 22:02:07 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:02:07 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:02:07 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:02:07 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x548d3a6b May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] PROTOCOMP May 23 22:02:07 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:02:07 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x19dc65f6 May 23 22:02:07 ppp [wan_link0] AUTHPROTO PAP May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] LCP: SendConfigAck #164 May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x19dc65f6 May 23 22:02:07 ppp [wan_link0] AUTHPROTO PAP May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] LCP: rec'd Configure Request #164 (Req-Sent) May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x548d3a6b May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] PROTOCOMP May 23 22:02:07 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:02:07 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:02:07 ppp [wan_link0] LCP: Up event May 23 22:02:07 ppp [wan_link0] Link: UP event May 23 22:02:07 ppp [wan_link0] PPPoE: connection successful May 23 22:02:07 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:02:06 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:02:06 ppp [wan_link0] LCP: LayerStart May 23 22:02:06 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:02:06 ppp [wan_link0] LCP: Open event May 23 22:02:06 ppp [wan_link0] Link: OPEN event May 23 22:02:06 ppp [wan] Bundle: Interface ng0 created May 23 22:02:06 ppp web: web is not running May 23 22:02:06 ppp process 19089 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:02:06 ppp Multi-link PPP daemon for FreeBSD May 23 22:02:02 ppp process 12700 terminated May 23 22:02:02 ppp [wan_link0] Link: Shutdown May 23 22:02:02 ppp [wan] Bundle: Shutdown May 23 22:02:00 ppp [wan_link0] LCP: Close event May 23 22:02:00 ppp [wan_link0] Link: CLOSE event May 23 22:02:00 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:02:00 ppp [wan_link0] LCP: LayerFinish May 23 22:02:00 ppp [wan_link0] LCP: Down event May 23 22:02:00 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:02:00 ppp [wan_link0] LCP: Close event May 23 22:02:00 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:02:00 ppp [wan_link0] Link: DOWN event May 23 22:02:00 ppp [wan_link0] PPPoE: connection closed May 23 22:02:00 ppp [wan_link0] LCP: LayerDown May 23 22:02:00 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:02:00 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:02:00 ppp [wan] IPV6CP: Down event May 23 22:02:00 ppp [wan] IPCP: state change Closed --> Initial May 23 22:02:00 ppp [wan] IPCP: Down event May 23 22:02:00 ppp [wan] IPV6CP: Close event May 23 22:02:00 ppp [wan] IPCP: Close event May 23 22:02:00 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:02:00 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:02:00 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:02:00 ppp [wan_link0] LCP: rec'd Terminate Request #74 (Opened) May 23 22:02:00 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:02:00 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:02:00 ppp [wan] IPCP: LayerFinish May 23 22:02:00 ppp [wan] IPCP: state change Closing --> Closed May 23 22:02:00 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:02:00 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:02:00 ppp [wan] IPV6CP: Close event May 23 22:02:00 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:02:00 ppp [wan] IFACE: Down event May 23 22:02:00 ppp [wan] IPCP: LayerDown May 23 22:02:00 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:02:00 ppp [wan] IPCP: state change Opened --> Closing May 23 22:02:00 ppp [wan] IPCP: Close event May 23 22:02:00 ppp [wan] IFACE: Close event May 23 22:02:00 ppp caught fatal signal TERM May 23 22:01:17 ppp [wan] IPV6CP: LayerFinish May 23 22:01:17 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:01:14 ppp [wan] IPV6CP: LayerDown May 23 22:01:14 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:01:14 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:01:14 ppp [wan] IPV6CP: rec'd Terminate Request #96 (Opened) May 23 22:01:14 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:01:14 ppp [wan] IPV6CP: LayerUp May 23 22:01:14 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:01:14 ppp [wan] IPV6CP: SendConfigAck #95 May 23 22:01:14 ppp [wan] IPV6CP: rec'd Configure Request #95 (Ack-Rcvd) May 23 22:01:14 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:01:14 ppp [wan] IFACE: Up event May 23 22:01:14 ppp [wan] 82.57.155.135 -> 192.168.100.1 May 23 22:01:14 ppp [wan] IPCP: LayerUp May 23 22:01:14 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:01:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:01:14 ppp [wan] IPCP: SendConfigAck #126 May 23 22:01:14 ppp [wan] 192.168.100.1 is OK May 23 22:01:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Request #126 (Ack-Rcvd) May 23 22:01:14 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:01:14 ppp [wan] IPADDR 82.57.155.135 May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:01:14 ppp [wan] IPADDR 82.57.155.135 May 23 22:01:14 ppp [wan] IPCP: SendConfigReq #3 May 23 22:01:14 ppp [wan] 82.57.155.135 is OK May 23 22:01:14 ppp [wan] IPADDR 82.57.155.135 May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:01:14 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:01:14 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:01:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:01:14 ppp [wan] IPCP: SendConfigReq #2 May 23 22:01:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:01:14 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:01:14 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:01:14 ppp [wan] IPV6CP: Up event May 23 22:01:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:01:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:01:14 ppp [wan] IPCP: SendConfigReq #1 May 23 22:01:14 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:01:14 ppp [wan] IPCP: Up event May 23 22:01:14 ppp [wan] IPV6CP: LayerStart May 23 22:01:14 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:01:14 ppp [wan] IPV6CP: Open event May 23 22:01:14 ppp [wan] IPCP: LayerStart May 23 22:01:14 ppp [wan] IPCP: state change Initial --> Starting May 23 22:01:14 ppp [wan] IPCP: Open event May 23 22:01:14 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:01:14 ppp [wan_link0] Link: Join bundle "wan" May 23 22:01:14 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:01:14 ppp [wan_link0] LCP: authorization successful May 23 22:01:14 ppp [wan_link0] MESG: REASON021 - TK MISSING: NOT IN DSL-LINE May 23 22:01:14 ppp [wan_link0] PAP: rec'd ACK #1 len: 44 May 23 22:01:14 ppp [wan_link0] LCP: LayerUp May 23 22:01:14 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:01:14 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:01:14 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:01:14 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:01:14 ppp [wan_link0] MAGICNUM 0xb8e86e4c May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] PROTOCOMP May 23 22:01:14 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:01:14 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:01:14 ppp [wan_link0] MAGICNUM 0x5e908b8b May 23 22:01:14 ppp [wan_link0] AUTHPROTO PAP May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] LCP: SendConfigAck #73 May 23 22:01:14 ppp [wan_link0] MAGICNUM 0x5e908b8b May 23 22:01:14 ppp [wan_link0] AUTHPROTO PAP May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] LCP: rec'd Configure Request #73 (Req-Sent) May 23 22:01:14 ppp [wan_link0] MAGICNUM 0xb8e86e4c May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] PROTOCOMP May 23 22:01:14 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:01:14 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:01:14 ppp [wan_link0] LCP: Up event May 23 22:01:14 ppp [wan_link0] Link: UP event May 23 22:01:14 ppp [wan_link0] PPPoE: connection successful May 23 22:01:14 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:01:14 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:01:14 ppp [wan_link0] LCP: LayerStart May 23 22:01:14 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:01:14 ppp [wan_link0] LCP: Open event May 23 22:01:14 ppp [wan_link0] Link: OPEN event May 23 22:01:14 ppp [wan] Bundle: Interface ng0 created May 23 22:01:14 ppp web: web is not running May 23 22:01:14 ppp process 12700 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:01:14 ppp Multi-link PPP daemon for FreeBSD May 23 22:01:11 ppp process 29992 terminated May 23 22:01:11 ppp [wan_link0] Link: Shutdown May 23 22:01:11 ppp [wan] Bundle: Shutdown May 23 22:01:09 ppp [wan_link0] LCP: Close event May 23 22:01:09 ppp [wan_link0] Link: CLOSE event May 23 22:01:09 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:01:09 ppp [wan_link0] LCP: LayerFinish May 23 22:01:09 ppp [wan_link0] LCP: Down event May 23 22:01:09 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:01:09 ppp [wan_link0] LCP: Close event May 23 22:01:09 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:01:09 ppp [wan_link0] Link: DOWN event May 23 22:01:09 ppp [wan_link0] PPPoE: connection closed May 23 22:01:09 ppp [wan_link0] LCP: LayerDown May 23 22:01:09 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:01:09 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:01:09 ppp [wan] IPV6CP: Down event May 23 22:01:09 ppp [wan] IPCP: state change Closed --> Initial May 23 22:01:09 ppp [wan] IPCP: Down event May 23 22:01:09 ppp [wan] IPV6CP: Close event May 23 22:01:09 ppp [wan] IPCP: Close event May 23 22:01:09 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:01:09 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:01:09 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:01:09 ppp [wan_link0] LCP: rec'd Terminate Request #19 (Opened) May 23 22:01:09 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:01:09 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:01:09 ppp [wan] IPCP: LayerFinish May 23 22:01:09 ppp [wan] IPCP: state change Closing --> Closed May 23 22:01:09 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:01:09 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:01:09 ppp [wan] IPV6CP: Close event May 23 22:01:09 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:01:09 ppp [wan] IFACE: Down event May 23 22:01:09 ppp [wan] IPCP: LayerDown May 23 22:01:09 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:01:09 ppp [wan] IPCP: state change Opened --> Closing May 23 22:01:09 ppp [wan] IPCP: Close event May 23 22:01:09 ppp [wan] IFACE: Close event May 23 22:01:09 ppp caught fatal signal TERM May 23 22:00:17 ppp [wan] IPV6CP: LayerFinish May 23 22:00:17 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:00:14 ppp [wan] IPV6CP: LayerDown May 23 22:00:14 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:00:14 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:00:14 ppp [wan] IPV6CP: rec'd Terminate Request #140 (Opened) May 23 22:00:14 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:00:14 ppp [wan] IPV6CP: LayerUp May 23 22:00:14 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:00:14 ppp [wan] IPV6CP: SendConfigAck #139 May 23 22:00:14 ppp [wan] IPV6CP: rec'd Configure Request #139 (Ack-Rcvd) May 23 22:00:14 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:00:14 ppp [wan] IFACE: Up event May 23 22:00:14 ppp [wan] 79.18.210.145 -> 192.168.100.1 May 23 22:00:14 ppp [wan] IPCP: LayerUp May 23 22:00:14 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:00:14 ppp [wan] IPCP: SendConfigAck #11 May 23 22:00:14 ppp [wan] 192.168.100.1 is OK May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Request #11 (Ack-Rcvd) May 23 22:00:14 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:00:14 ppp [wan] IPADDR 79.18.210.145 May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:00:14 ppp [wan] IPADDR 79.18.210.145 May 23 22:00:14 ppp [wan] IPCP: SendConfigReq #3 May 23 22:00:14 ppp [wan] 79.18.210.145 is OK May 23 22:00:14 ppp [wan] IPADDR 79.18.210.145 May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:00:14 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:00:14 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:00:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:00:14 ppp [wan] IPCP: SendConfigReq #2 May 23 22:00:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:00:14 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:00:14 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:00:14 ppp [wan] IPV6CP: Up event May 23 22:00:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:00:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:00:14 ppp [wan] IPCP: SendConfigReq #1 May 23 22:00:14 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:00:14 ppp [wan] IPCP: Up event May 23 22:00:14 ppp [wan] IPV6CP: LayerStart May 23 22:00:14 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:00:14 ppp [wan] IPV6CP: Open event May 23 22:00:14 ppp [wan] IPCP: LayerStart May 23 22:00:14 ppp [wan] IPCP: state change Initial --> Starting May 23 22:00:14 ppp [wan] IPCP: Open event May 23 22:00:14 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:00:14 ppp [wan_link0] Link: Join bundle "wan" May 23 22:00:14 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:00:14 ppp [wan_link0] LCP: authorization successful May 23 22:00:14 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:00:14 ppp [wan_link0] LCP: LayerUp May 23 22:00:14 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:00:14 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:00:14 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:00:14 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:00:14 ppp [wan_link0] MAGICNUM 0x668d5328 May 23 22:00:14 ppp [wan_link0] MRU 1492 May 23 22:00:14 ppp [wan_link0] PROTOCOMP May 23 22:00:14 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:00:14 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:00:14 ppp [wan_link0] MAGICNUM 0x534f4cbb May 23 22:00:14 ppp [wan_link0] AUTHPROTO PAP May 23 22:00:14 ppp [wan_link0] MRU 1492 May 23 22:00:14 ppp [wan_link0] LCP: SendConfigAck #18 May 23 22:00:14 ppp [wan_link0] MAGICNUM 0x534f4cbb
-
Hi CMB,
thanks for your reply. :)Here is PPP logs:
May 23 22:11:31 ppp [wan] IPV6CP: LayerFinish May 23 22:11:31 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:11:28 ppp [wan] IPV6CP: LayerDown May 23 22:11:28 ppp [wan] IPV6CP: SendTerminateAck #6 May 23 22:11:28 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:11:28 ppp [wan] IPV6CP: rec'd Terminate Request #212 (Opened) May 23 22:11:28 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:11:28 ppp [wan] IPV6CP: LayerUp May 23 22:11:28 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:11:28 ppp [wan] IPV6CP: SendConfigAck #211 May 23 22:11:28 ppp [wan] IPV6CP: rec'd Configure Request #211 (Ack-Rcvd) May 23 22:11:28 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:11:28 ppp [wan] IPV6CP: rec'd Configure Ack #5 (Req-Sent) May 23 22:11:28 ppp [wan] IPV6CP: SendConfigReq #5 May 23 22:11:26 ppp [wan] IPV6CP: SendTerminateAck #4 May 23 22:11:26 ppp [wan] IPV6CP: state change Ack-Sent --> Req-Sent May 23 22:11:26 ppp [wan] IPV6CP: rec'd Terminate Request #1 (Ack-Sent) May 23 22:11:26 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Sent May 23 22:11:26 ppp [wan] IPV6CP: SendConfigAck #0 May 23 22:11:26 ppp [wan] IPV6CP: rec'd Configure Request #0 (Req-Sent) May 23 22:11:26 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:11:26 ppp [wan] IFACE: Up event May 23 22:11:26 ppp [wan] 87.21.211.177 -> 192.168.100.1 May 23 22:11:26 ppp [wan] IPCP: LayerUp May 23 22:11:26 ppp [wan] IPCP: state change Ack-Sent --> Opened May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177 May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) May 23 22:11:26 ppp [wan] IPCP: state change Req-Sent --> Ack-Sent May 23 22:11:26 ppp [wan] IPADDR 192.168.100.1 May 23 22:11:26 ppp [wan] IPCP: SendConfigAck #181 May 23 22:11:26 ppp [wan] 192.168.100.1 is OK May 23 22:11:26 ppp [wan] IPADDR 192.168.100.1 May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Request #181 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: SendTerminateAck #3 May 23 22:11:26 ppp [wan] IPV6CP: rec'd Terminate Request #255 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:11:26 ppp [wan] IPV6CP: state change Ack-Rcvd --> Req-Sent May 23 22:11:26 ppp [wan] IPV6CP: rec'd Terminate Request #254 (Ack-Rcvd) May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177 May 23 22:11:26 ppp [wan] IPCP: SendConfigReq #3 May 23 22:11:26 ppp [wan] 87.21.211.177 is OK May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177 May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:11:26 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:11:26 ppp [wan] IPADDR 0.0.0.0 May 23 22:11:26 ppp [wan] IPCP: SendConfigReq #2 May 23 22:11:26 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:11:26 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:11:26 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:11:26 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:11:26 ppp [wan] IPV6CP: Up event May 23 22:11:26 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:11:26 ppp [wan] IPADDR 0.0.0.0 May 23 22:11:26 ppp [wan] IPCP: SendConfigReq #1 May 23 22:11:26 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:11:26 ppp [wan] IPCP: Up event May 23 22:11:26 ppp [wan] IPV6CP: LayerStart May 23 22:11:26 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:11:26 ppp [wan] IPV6CP: Open event May 23 22:11:26 ppp [wan] IPCP: LayerStart May 23 22:11:26 ppp [wan] IPCP: state change Initial --> Starting May 23 22:11:26 ppp [wan] IPCP: Open event May 23 22:11:26 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:11:26 ppp [wan_link0] Link: Join bundle "wan" May 23 22:11:26 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:11:26 ppp [wan_link0] LCP: authorization successful May 23 22:11:26 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:11:26 ppp [wan_link0] LCP: LayerUp May 23 22:11:26 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:11:26 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:11:26 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:11:26 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:11:26 ppp [wan_link0] MAGICNUM 0xcef11f0e May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] PROTOCOMP May 23 22:11:26 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:11:26 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:11:26 ppp [wan_link0] MAGICNUM 0x536a27fa May 23 22:11:26 ppp [wan_link0] AUTHPROTO PAP May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] LCP: SendConfigAck #56 May 23 22:11:26 ppp [wan_link0] MAGICNUM 0x536a27fa May 23 22:11:26 ppp [wan_link0] AUTHPROTO PAP May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] LCP: rec'd Configure Request #56 (Req-Sent) May 23 22:11:26 ppp [wan_link0] MAGICNUM 0xcef11f0e May 23 22:11:26 ppp [wan_link0] MRU 1492 May 23 22:11:26 ppp [wan_link0] PROTOCOMP May 23 22:11:26 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:11:26 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:11:26 ppp [wan_link0] LCP: Up event May 23 22:11:26 ppp [wan_link0] Link: UP event May 23 22:11:26 ppp [wan_link0] PPPoE: connection successful May 23 22:11:26 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:11:25 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:11:25 ppp [wan_link0] LCP: LayerStart May 23 22:11:25 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:11:25 ppp [wan_link0] LCP: Open event May 23 22:11:25 ppp [wan_link0] Link: OPEN event May 23 22:11:25 ppp [wan] Bundle: Interface ng0 created May 23 22:11:25 ppp web: web is not running May 23 22:11:25 ppp process 84326 terminated May 23 22:11:25 ppp [wan_link0] Link: Shutdown May 23 22:11:25 ppp [wan] Bundle: Shutdown May 23 22:11:24 ppp waiting for process 84326 to die... May 23 22:11:24 ppp process 12005 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:11:24 ppp Multi-link PPP daemon for FreeBSD May 23 22:11:23 ppp [wan_link0] LCP: Close event May 23 22:11:23 ppp [wan_link0] Link: CLOSE event May 23 22:11:23 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:11:23 ppp [wan_link0] LCP: LayerFinish May 23 22:11:23 ppp [wan_link0] LCP: Down event May 23 22:11:23 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:11:23 ppp [wan_link0] LCP: Close event May 23 22:11:23 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:11:23 ppp [wan_link0] Link: DOWN event May 23 22:11:23 ppp [wan_link0] PPPoE: connection closed May 23 22:11:23 ppp [wan_link0] LCP: LayerDown May 23 22:11:23 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:11:23 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:11:23 ppp [wan] IPV6CP: Down event May 23 22:11:23 ppp [wan] IPCP: state change Closed --> Initial May 23 22:11:23 ppp [wan] IPCP: Down event May 23 22:11:23 ppp [wan] IPV6CP: Close event May 23 22:11:23 ppp [wan] IPCP: Close event May 23 22:11:23 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:11:23 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:11:23 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:11:23 ppp [wan_link0] LCP: rec'd Terminate Request #24 (Opened) May 23 22:11:23 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:11:23 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:11:23 ppp [wan] IPCP: LayerFinish May 23 22:11:23 ppp [wan] IPCP: state change Closing --> Closed May 23 22:11:23 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:11:23 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:11:23 ppp [wan] IPV6CP: Close event May 23 22:11:23 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:11:23 ppp [wan] IFACE: Down event May 23 22:11:22 ppp [wan] IPCP: LayerDown May 23 22:11:22 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:11:22 ppp [wan] IPCP: state change Opened --> Closing May 23 22:11:22 ppp [wan] IPCP: Close event May 23 22:11:22 ppp [wan] IFACE: Close event May 23 22:11:22 ppp caught fatal signal TERM May 23 22:09:14 ppp [wan] IPV6CP: LayerFinish May 23 22:09:14 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:09:12 ppp [wan] IPV6CP: LayerDown May 23 22:09:12 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:09:12 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:09:12 ppp [wan] IPV6CP: rec'd Terminate Request #184 (Opened) May 23 22:09:12 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:09:12 ppp [wan] IPV6CP: LayerUp May 23 22:09:12 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:09:12 ppp [wan] IPV6CP: SendConfigAck #183 May 23 22:09:12 ppp [wan] IPV6CP: rec'd Configure Request #183 (Ack-Rcvd) May 23 22:09:12 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:09:12 ppp [wan] IFACE: Up event May 23 22:09:12 ppp [wan] 82.53.152.239 -> 192.168.100.1 May 23 22:09:12 ppp [wan] IPCP: LayerUp May 23 22:09:12 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:09:12 ppp [wan] IPADDR 192.168.100.1 May 23 22:09:12 ppp [wan] IPCP: SendConfigAck #247 May 23 22:09:12 ppp [wan] 192.168.100.1 is OK May 23 22:09:12 ppp [wan] IPADDR 192.168.100.1 May 23 22:09:12 ppp [wan] IPCP: rec'd Configure Request #247 (Ack-Rcvd) May 23 22:09:12 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:09:12 ppp [wan] IPADDR 82.53.152.239 May 23 22:09:12 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:09:12 ppp [wan] IPADDR 82.53.152.239 May 23 22:09:12 ppp [wan] IPCP: SendConfigReq #3 May 23 22:09:12 ppp [wan] 82.53.152.239 is OK May 23 22:09:12 ppp [wan] IPADDR 82.53.152.239 May 23 22:09:12 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:09:11 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:09:11 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:09:11 ppp [wan] IPADDR 0.0.0.0 May 23 22:09:11 ppp [wan] IPCP: SendConfigReq #2 May 23 22:09:11 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:09:11 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:09:11 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:09:11 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:09:11 ppp [wan] IPV6CP: Up event May 23 22:09:11 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:09:11 ppp [wan] IPADDR 0.0.0.0 May 23 22:09:11 ppp [wan] IPCP: SendConfigReq #1 May 23 22:09:11 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:09:11 ppp [wan] IPCP: Up event May 23 22:09:11 ppp [wan] IPV6CP: LayerStart May 23 22:09:11 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:09:11 ppp [wan] IPV6CP: Open event May 23 22:09:11 ppp [wan] IPCP: LayerStart May 23 22:09:11 ppp [wan] IPCP: state change Initial --> Starting May 23 22:09:11 ppp [wan] IPCP: Open event May 23 22:09:11 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:09:11 ppp [wan_link0] Link: Join bundle "wan" May 23 22:09:11 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:09:11 ppp [wan_link0] LCP: authorization successful May 23 22:09:11 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:09:11 ppp [wan_link0] LCP: LayerUp May 23 22:09:11 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:09:11 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:09:11 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:09:11 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x79b7508e May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] PROTOCOMP May 23 22:09:11 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:09:11 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x3406c6c8 May 23 22:09:11 ppp [wan_link0] AUTHPROTO PAP May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] LCP: SendConfigAck #23 May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x3406c6c8 May 23 22:09:11 ppp [wan_link0] AUTHPROTO PAP May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] LCP: rec'd Configure Request #23 (Req-Sent) May 23 22:09:11 ppp [wan_link0] MAGICNUM 0x79b7508e May 23 22:09:11 ppp [wan_link0] MRU 1492 May 23 22:09:11 ppp [wan_link0] PROTOCOMP May 23 22:09:11 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:09:11 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:09:11 ppp [wan_link0] LCP: Up event May 23 22:09:11 ppp [wan_link0] Link: UP event May 23 22:09:11 ppp [wan_link0] PPPoE: connection successful May 23 22:09:11 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:09:11 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:09:11 ppp [wan_link0] LCP: LayerStart May 23 22:09:11 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:09:11 ppp [wan_link0] LCP: Open event May 23 22:09:11 ppp [wan_link0] Link: OPEN event May 23 22:09:11 ppp [wan] Bundle: Interface ng0 created May 23 22:09:11 ppp web: web is not running May 23 22:09:10 ppp process 91397 terminated May 23 22:09:10 ppp [wan_link0] Link: Shutdown May 23 22:09:10 ppp [wan] Bundle: Shutdown May 23 22:09:10 ppp waiting for process 91397 to die... May 23 22:09:10 ppp process 84326 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:09:10 ppp Multi-link PPP daemon for FreeBSD May 23 22:09:08 ppp [wan_link0] LCP: Close event May 23 22:09:08 ppp [wan_link0] Link: CLOSE event May 23 22:09:08 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:09:08 ppp [wan_link0] LCP: LayerFinish May 23 22:09:08 ppp [wan_link0] LCP: Down event May 23 22:09:08 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:09:08 ppp [wan_link0] LCP: Close event May 23 22:09:08 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:09:08 ppp [wan_link0] Link: DOWN event May 23 22:09:08 ppp [wan_link0] PPPoE: connection closed May 23 22:09:08 ppp [wan_link0] LCP: LayerDown May 23 22:09:08 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:09:08 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:09:08 ppp [wan] IPV6CP: Down event May 23 22:09:08 ppp [wan] IPCP: state change Closed --> Initial May 23 22:09:08 ppp [wan] IPCP: Down event May 23 22:09:08 ppp [wan] IPV6CP: Close event May 23 22:09:08 ppp [wan] IPCP: Close event May 23 22:09:08 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:09:08 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:09:08 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:09:08 ppp [wan_link0] LCP: rec'd Terminate Request #148 (Opened) May 23 22:09:08 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:09:08 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:09:08 ppp [wan] IPCP: LayerFinish May 23 22:09:08 ppp [wan] IPCP: state change Closing --> Closed May 23 22:09:08 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:09:08 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:09:08 ppp [wan] IPV6CP: Close event May 23 22:09:08 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:09:08 ppp [wan] IFACE: Down event May 23 22:09:08 ppp [wan] IPCP: LayerDown May 23 22:09:08 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:09:08 ppp [wan] IPCP: state change Opened --> Closing May 23 22:09:08 ppp [wan] IPCP: Close event May 23 22:09:08 ppp [wan] IFACE: Close event May 23 22:09:08 ppp caught fatal signal TERM May 23 22:07:06 ppp [wan] IPV6CP: LayerFinish May 23 22:07:06 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:07:04 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:07:04 ppp [wan] IFACE: Up event May 23 22:07:04 ppp [wan] 87.1.223.81 -> 192.168.100.1 May 23 22:07:04 ppp [wan] IPCP: LayerUp May 23 22:07:04 ppp [wan] IPCP: state change Ack-Sent --> Opened May 23 22:07:04 ppp [wan] IPADDR 87.1.223.81 May 23 22:07:04 ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) May 23 22:07:04 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:07:04 ppp [wan] IFACE: Down event May 23 22:07:03 ppp [wan] IPV6CP: LayerDown May 23 22:07:03 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:07:03 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:07:03 ppp [wan] IPV6CP: rec'd Terminate Request #193 (Opened) May 23 22:07:03 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:07:03 ppp [wan] IFACE: Up event May 23 22:07:03 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:07:03 ppp [wan] IPV6CP: LayerUp May 23 22:07:03 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:07:03 ppp [wan] IPV6CP: SendConfigAck #192 May 23 22:07:03 ppp [wan] IPV6CP: rec'd Configure Request #192 (Ack-Rcvd) May 23 22:07:03 ppp [wan] IPADDR 87.1.223.81 May 23 22:07:03 ppp [wan] IPCP: SendConfigReq #3 May 23 22:07:03 ppp [wan] 87.1.223.81 is OK May 23 22:07:03 ppp [wan] IPADDR 87.1.223.81 May 23 22:07:03 ppp [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent) May 23 22:07:03 ppp [wan] IPCP: state change Req-Sent --> Ack-Sent May 23 22:07:03 ppp [wan] IPADDR 192.168.100.1 May 23 22:07:03 ppp [wan] IPCP: SendConfigAck #172 May 23 22:07:03 ppp [wan] 192.168.100.1 is OK May 23 22:07:03 ppp [wan] IPADDR 192.168.100.1 May 23 22:07:03 ppp [wan] IPCP: rec'd Configure Request #172 (Req-Sent) May 23 22:07:03 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:07:03 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:07:03 ppp [wan] IPADDR 0.0.0.0 May 23 22:07:03 ppp [wan] IPCP: SendConfigReq #2 May 23 22:07:03 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:07:03 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:07:03 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:07:03 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:07:03 ppp [wan] IPV6CP: Up event May 23 22:07:03 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:07:03 ppp [wan] IPADDR 0.0.0.0 May 23 22:07:03 ppp [wan] IPCP: SendConfigReq #1 May 23 22:07:03 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:07:03 ppp [wan] IPCP: Up event May 23 22:07:03 ppp [wan] IPV6CP: LayerStart May 23 22:07:03 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:07:03 ppp [wan] IPV6CP: Open event May 23 22:07:03 ppp [wan] IPCP: LayerStart May 23 22:07:03 ppp [wan] IPCP: state change Initial --> Starting May 23 22:07:03 ppp [wan] IPCP: Open event May 23 22:07:03 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:07:03 ppp [wan_link0] Link: Join bundle "wan" May 23 22:07:03 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:07:03 ppp [wan_link0] LCP: authorization successful May 23 22:07:03 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:07:03 ppp [wan_link0] LCP: LayerUp May 23 22:07:03 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:07:03 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:07:03 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:07:03 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x5cce6d32 May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] PROTOCOMP May 23 22:07:03 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:07:03 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x30b57178 May 23 22:07:03 ppp [wan_link0] AUTHPROTO PAP May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] LCP: SendConfigAck #147 May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x30b57178 May 23 22:07:03 ppp [wan_link0] AUTHPROTO PAP May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] LCP: rec'd Configure Request #147 (Req-Sent) May 23 22:07:03 ppp [wan_link0] MAGICNUM 0x5cce6d32 May 23 22:07:03 ppp [wan_link0] MRU 1492 May 23 22:07:03 ppp [wan_link0] PROTOCOMP May 23 22:07:03 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:07:03 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:07:03 ppp [wan_link0] LCP: Up event May 23 22:07:03 ppp [wan_link0] Link: UP event May 23 22:07:03 ppp [wan_link0] PPPoE: connection successful May 23 22:07:03 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:07:03 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:07:03 ppp [wan_link0] LCP: LayerStart May 23 22:07:03 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:07:03 ppp [wan_link0] LCP: Open event May 23 22:07:03 ppp [wan_link0] Link: OPEN event May 23 22:07:03 ppp [wan] Bundle: Interface ng0 created May 23 22:07:03 ppp web: web is not running May 23 22:07:03 ppp process 91397 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:07:03 ppp Multi-link PPP daemon for FreeBSD May 23 22:06:49 ppp process 8514 terminated May 23 22:06:49 ppp [wan_link0] Link: Shutdown May 23 22:06:49 ppp [wan] Bundle: Shutdown May 23 22:06:47 ppp [wan_link0] LCP: Close event May 23 22:06:47 ppp [wan_link0] Link: CLOSE event May 23 22:06:47 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:06:47 ppp [wan_link0] LCP: LayerFinish May 23 22:06:47 ppp [wan_link0] LCP: Down event May 23 22:06:47 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:06:47 ppp [wan_link0] LCP: Close event May 23 22:06:47 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:06:47 ppp [wan_link0] Link: DOWN event May 23 22:06:47 ppp [wan_link0] PPPoE: connection closed May 23 22:06:47 ppp [wan_link0] LCP: LayerDown May 23 22:06:47 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:06:47 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:06:47 ppp [wan] IPV6CP: Down event May 23 22:06:47 ppp [wan] IPCP: state change Closed --> Initial May 23 22:06:47 ppp [wan] IPCP: Down event May 23 22:06:47 ppp [wan] IPV6CP: Close event May 23 22:06:47 ppp [wan] IPCP: Close event May 23 22:06:47 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:06:47 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:06:47 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:06:47 ppp [wan_link0] LCP: rec'd Terminate Request #204 (Opened) May 23 22:06:47 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:06:47 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:06:47 ppp [wan] IPCP: LayerFinish May 23 22:06:47 ppp [wan] IPCP: state change Closing --> Closed May 23 22:06:47 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:06:47 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:06:47 ppp [wan] IPV6CP: Close event May 23 22:06:47 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:06:47 ppp [wan] IFACE: Down event May 23 22:06:46 ppp [wan] IPCP: LayerDown May 23 22:06:46 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:06:46 ppp [wan] IPCP: state change Opened --> Closing May 23 22:06:46 ppp [wan] IPCP: Close event May 23 22:06:46 ppp [wan] IFACE: Close event May 23 22:06:46 ppp caught fatal signal TERM May 23 22:05:05 ppp [wan] IPV6CP: LayerFinish May 23 22:05:05 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:05:03 ppp [wan] IPV6CP: LayerDown May 23 22:05:03 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:05:03 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:05:03 ppp [wan] IPV6CP: rec'd Terminate Request #82 (Opened) May 23 22:05:02 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:05:02 ppp [wan] IPV6CP: LayerUp May 23 22:05:02 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:05:02 ppp [wan] IPV6CP: SendConfigAck #81 May 23 22:05:02 ppp [wan] IPV6CP: rec'd Configure Request #81 (Ack-Rcvd) May 23 22:05:02 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:05:02 ppp [wan] IFACE: Up event May 23 22:05:02 ppp [wan] 82.51.149.195 -> 192.168.100.1 May 23 22:05:02 ppp [wan] IPCP: LayerUp May 23 22:05:02 ppp [wan] IPCP: state change Ack-Sent --> Opened May 23 22:05:02 ppp [wan] IPADDR 82.51.149.195 May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) May 23 22:05:02 ppp [wan] IPCP: state change Req-Sent --> Ack-Sent May 23 22:05:02 ppp [wan] IPADDR 192.168.100.1 May 23 22:05:02 ppp [wan] IPCP: SendConfigAck #15 May 23 22:05:02 ppp [wan] 192.168.100.1 is OK May 23 22:05:02 ppp [wan] IPADDR 192.168.100.1 May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Request #15 (Req-Sent) May 23 22:05:02 ppp [wan] IPADDR 82.51.149.195 May 23 22:05:02 ppp [wan] IPCP: SendConfigReq #3 May 23 22:05:02 ppp [wan] 82.51.149.195 is OK May 23 22:05:02 ppp [wan] IPADDR 82.51.149.195 May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:05:02 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:05:02 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:05:02 ppp [wan] IPADDR 0.0.0.0 May 23 22:05:02 ppp [wan] IPCP: SendConfigReq #2 May 23 22:05:02 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:05:02 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:05:02 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:05:02 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:05:02 ppp [wan] IPV6CP: Up event May 23 22:05:02 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:05:02 ppp [wan] IPADDR 0.0.0.0 May 23 22:05:02 ppp [wan] IPCP: SendConfigReq #1 May 23 22:05:02 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:05:02 ppp [wan] IPCP: Up event May 23 22:05:02 ppp [wan] IPV6CP: LayerStart May 23 22:05:02 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:05:02 ppp [wan] IPV6CP: Open event May 23 22:05:02 ppp [wan] IPCP: LayerStart May 23 22:05:02 ppp [wan] IPCP: state change Initial --> Starting May 23 22:05:02 ppp [wan] IPCP: Open event May 23 22:05:02 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:05:02 ppp [wan_link0] Link: Join bundle "wan" May 23 22:05:02 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:05:02 ppp [wan_link0] LCP: authorization successful May 23 22:05:02 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:05:02 ppp [wan_link0] LCP: LayerUp May 23 22:05:02 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:05:02 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:05:02 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:05:02 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x57f267c0 May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] PROTOCOMP May 23 22:05:02 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:05:02 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x2e5d1f70 May 23 22:05:02 ppp [wan_link0] AUTHPROTO PAP May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] LCP: SendConfigAck #203 May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x2e5d1f70 May 23 22:05:02 ppp [wan_link0] AUTHPROTO PAP May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] LCP: rec'd Configure Request #203 (Req-Sent) May 23 22:05:02 ppp [wan_link0] MAGICNUM 0x57f267c0 May 23 22:05:02 ppp [wan_link0] MRU 1492 May 23 22:05:02 ppp [wan_link0] PROTOCOMP May 23 22:05:02 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:05:02 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:05:02 ppp [wan_link0] LCP: Up event May 23 22:05:02 ppp [wan_link0] Link: UP event May 23 22:05:02 ppp [wan_link0] PPPoE: connection successful May 23 22:05:02 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:05:02 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:05:02 ppp [wan_link0] LCP: LayerStart May 23 22:05:02 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:05:02 ppp [wan_link0] LCP: Open event May 23 22:05:02 ppp [wan_link0] Link: OPEN event May 23 22:05:02 ppp [wan] Bundle: Interface ng0 created May 23 22:05:02 ppp web: web is not running May 23 22:05:02 ppp process 8514 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:05:02 ppp Multi-link PPP daemon for FreeBSD May 23 22:04:54 ppp process 67736 terminated May 23 22:04:54 ppp [wan_link0] Link: Shutdown May 23 22:04:54 ppp [wan] Bundle: Shutdown May 23 22:04:52 ppp [wan_link0] LCP: Close event May 23 22:04:52 ppp [wan_link0] Link: CLOSE event May 23 22:04:52 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:04:52 ppp [wan_link0] LCP: LayerFinish May 23 22:04:52 ppp [wan_link0] LCP: Down event May 23 22:04:52 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:04:52 ppp [wan_link0] LCP: Close event May 23 22:04:52 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:04:52 ppp [wan_link0] Link: DOWN event May 23 22:04:52 ppp [wan_link0] PPPoE: connection closed May 23 22:04:52 ppp [wan_link0] LCP: LayerDown May 23 22:04:52 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:04:52 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:04:52 ppp [wan] IPV6CP: Down event May 23 22:04:52 ppp [wan] IPCP: state change Closed --> Initial May 23 22:04:52 ppp [wan] IPCP: Down event May 23 22:04:52 ppp [wan] IPV6CP: Close event May 23 22:04:52 ppp [wan] IPCP: Close event May 23 22:04:52 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:04:52 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:04:52 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:04:52 ppp [wan_link0] LCP: rec'd Terminate Request #148 (Opened) May 23 22:04:52 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:04:52 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:04:52 ppp [wan] IPCP: LayerFinish May 23 22:04:52 ppp [wan] IPCP: state change Closing --> Closed May 23 22:04:52 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:04:52 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:04:52 ppp [wan] IPV6CP: Close event May 23 22:04:52 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:04:52 ppp [wan] IFACE: Down event May 23 22:04:52 ppp [wan] IPCP: LayerDown May 23 22:04:52 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:04:52 ppp [wan] IPCP: state change Opened --> Closing May 23 22:04:52 ppp [wan] IPCP: Close event May 23 22:04:52 ppp [wan] IFACE: Close event May 23 22:04:52 ppp caught fatal signal TERM May 23 22:04:18 ppp [wan] IPV6CP: LayerFinish May 23 22:04:18 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:04:15 ppp [wan] IPV6CP: LayerDown May 23 22:04:15 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:04:15 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:04:15 ppp [wan] IPV6CP: rec'd Terminate Request #174 (Opened) May 23 22:04:15 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:04:15 ppp [wan] IPV6CP: LayerUp May 23 22:04:15 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:04:15 ppp [wan] IPV6CP: SendConfigAck #173 May 23 22:04:15 ppp [wan] IPV6CP: rec'd Configure Request #173 (Ack-Rcvd) May 23 22:04:15 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:04:15 ppp [wan] IFACE: Up event May 23 22:04:15 ppp [wan] 82.51.146.47 -> 192.168.100.1 May 23 22:04:15 ppp [wan] IPCP: LayerUp May 23 22:04:15 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:04:15 ppp [wan] IPADDR 192.168.100.1 May 23 22:04:15 ppp [wan] IPCP: SendConfigAck #100 May 23 22:04:15 ppp [wan] 192.168.100.1 is OK May 23 22:04:15 ppp [wan] IPADDR 192.168.100.1 May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Request #100 (Ack-Rcvd) May 23 22:04:15 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:04:15 ppp [wan] IPADDR 82.51.146.47 May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:04:15 ppp [wan] IPADDR 82.51.146.47 May 23 22:04:15 ppp [wan] IPCP: SendConfigReq #3 May 23 22:04:15 ppp [wan] 82.51.146.47 is OK May 23 22:04:15 ppp [wan] IPADDR 82.51.146.47 May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:04:15 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:04:15 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:04:15 ppp [wan] IPADDR 0.0.0.0 May 23 22:04:15 ppp [wan] IPCP: SendConfigReq #2 May 23 22:04:15 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:04:15 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:04:15 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:04:15 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:04:15 ppp [wan] IPV6CP: Up event May 23 22:04:15 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:04:15 ppp [wan] IPADDR 0.0.0.0 May 23 22:04:15 ppp [wan] IPCP: SendConfigReq #1 May 23 22:04:15 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:04:15 ppp [wan] IPCP: Up event May 23 22:04:15 ppp [wan] IPV6CP: LayerStart May 23 22:04:15 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:04:15 ppp [wan] IPV6CP: Open event May 23 22:04:15 ppp [wan] IPCP: LayerStart May 23 22:04:15 ppp [wan] IPCP: state change Initial --> Starting May 23 22:04:15 ppp [wan] IPCP: Open event May 23 22:04:15 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:04:15 ppp [wan_link0] Link: Join bundle "wan" May 23 22:04:15 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:04:15 ppp [wan_link0] LCP: authorization successful May 23 22:04:15 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:04:15 ppp [wan_link0] LCP: LayerUp May 23 22:04:15 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:04:15 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:04:15 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:04:15 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7a955848 May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] PROTOCOMP May 23 22:04:15 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:04:15 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7340e4e0 May 23 22:04:15 ppp [wan_link0] AUTHPROTO PAP May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] LCP: SendConfigAck #147 May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7340e4e0 May 23 22:04:15 ppp [wan_link0] AUTHPROTO PAP May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] LCP: rec'd Configure Request #147 (Req-Sent) May 23 22:04:15 ppp [wan_link0] MAGICNUM 0x7a955848 May 23 22:04:15 ppp [wan_link0] MRU 1492 May 23 22:04:15 ppp [wan_link0] PROTOCOMP May 23 22:04:15 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:04:15 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:04:15 ppp [wan_link0] LCP: Up event May 23 22:04:15 ppp [wan_link0] Link: UP event May 23 22:04:15 ppp [wan_link0] PPPoE: connection successful May 23 22:04:15 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:04:15 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:04:15 ppp [wan_link0] LCP: LayerStart May 23 22:04:15 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:04:15 ppp [wan_link0] LCP: Open event May 23 22:04:15 ppp [wan_link0] Link: OPEN event May 23 22:04:15 ppp [wan] Bundle: Interface ng0 created May 23 22:04:15 ppp web: web is not running May 23 22:04:15 ppp process 67736 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:04:15 ppp Multi-link PPP daemon for FreeBSD May 23 22:04:13 ppp process 19089 terminated May 23 22:04:13 ppp [wan_link0] Link: Shutdown May 23 22:04:13 ppp [wan] Bundle: Shutdown May 23 22:04:11 ppp [wan_link0] LCP: Close event May 23 22:04:11 ppp [wan_link0] Link: CLOSE event May 23 22:04:11 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:04:11 ppp [wan_link0] LCP: LayerFinish May 23 22:04:11 ppp [wan_link0] LCP: Down event May 23 22:04:11 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:04:11 ppp [wan_link0] LCP: Close event May 23 22:04:11 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:04:11 ppp [wan_link0] Link: DOWN event May 23 22:04:11 ppp [wan_link0] PPPoE: connection closed May 23 22:04:11 ppp [wan_link0] LCP: LayerDown May 23 22:04:11 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:04:11 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:04:11 ppp [wan] IPV6CP: Down event May 23 22:04:11 ppp [wan] IPCP: state change Closed --> Initial May 23 22:04:11 ppp [wan] IPCP: Down event May 23 22:04:11 ppp [wan] IPV6CP: Close event May 23 22:04:11 ppp [wan] IPCP: Close event May 23 22:04:11 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:04:11 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:04:11 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:04:11 ppp [wan_link0] LCP: rec'd Terminate Request #165 (Opened) May 23 22:04:11 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:04:11 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:04:11 ppp [wan] IPCP: LayerFinish May 23 22:04:11 ppp [wan] IPCP: state change Closing --> Closed May 23 22:04:11 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:04:11 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:04:11 ppp [wan] IPV6CP: Close event May 23 22:04:11 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:04:11 ppp [wan] IFACE: Down event May 23 22:04:11 ppp [wan] IPCP: LayerDown May 23 22:04:11 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:04:11 ppp [wan] IPCP: state change Opened --> Closing May 23 22:04:11 ppp [wan] IPCP: Close event May 23 22:04:11 ppp [wan] IFACE: Close event May 23 22:04:11 ppp caught fatal signal TERM May 23 22:02:10 ppp [wan] IPV6CP: LayerFinish May 23 22:02:10 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:02:08 ppp [wan] IPV6CP: LayerDown May 23 22:02:08 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:02:08 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:02:08 ppp [wan] IPV6CP: rec'd Terminate Request #223 (Opened) May 23 22:02:08 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:02:08 ppp [wan] IPV6CP: LayerUp May 23 22:02:08 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:02:08 ppp [wan] IPV6CP: SendConfigAck #222 May 23 22:02:08 ppp [wan] IPV6CP: rec'd Configure Request #222 (Ack-Rcvd) May 23 22:02:08 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:02:08 ppp [wan] IFACE: Up event May 23 22:02:08 ppp [wan] 87.6.212.160 -> 192.168.100.1 May 23 22:02:08 ppp [wan] IPCP: LayerUp May 23 22:02:08 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:02:08 ppp [wan] IPADDR 192.168.100.1 May 23 22:02:08 ppp [wan] IPCP: SendConfigAck #157 May 23 22:02:08 ppp [wan] 192.168.100.1 is OK May 23 22:02:08 ppp [wan] IPADDR 192.168.100.1 May 23 22:02:08 ppp [wan] IPCP: rec'd Configure Request #157 (Ack-Rcvd) May 23 22:02:07 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:02:07 ppp [wan] IPADDR 87.6.212.160 May 23 22:02:07 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:02:07 ppp [wan] IPADDR 87.6.212.160 May 23 22:02:07 ppp [wan] IPCP: SendConfigReq #3 May 23 22:02:07 ppp [wan] 87.6.212.160 is OK May 23 22:02:07 ppp [wan] IPADDR 87.6.212.160 May 23 22:02:07 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:02:07 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:02:07 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:02:07 ppp [wan] IPADDR 0.0.0.0 May 23 22:02:07 ppp [wan] IPCP: SendConfigReq #2 May 23 22:02:07 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:02:07 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:02:07 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:02:07 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:02:07 ppp [wan] IPV6CP: Up event May 23 22:02:07 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:02:07 ppp [wan] IPADDR 0.0.0.0 May 23 22:02:07 ppp [wan] IPCP: SendConfigReq #1 May 23 22:02:07 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:02:07 ppp [wan] IPCP: Up event May 23 22:02:07 ppp [wan] IPV6CP: LayerStart May 23 22:02:07 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:02:07 ppp [wan] IPV6CP: Open event May 23 22:02:07 ppp [wan] IPCP: LayerStart May 23 22:02:07 ppp [wan] IPCP: state change Initial --> Starting May 23 22:02:07 ppp [wan] IPCP: Open event May 23 22:02:07 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:02:07 ppp [wan_link0] Link: Join bundle "wan" May 23 22:02:07 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:02:07 ppp [wan_link0] LCP: authorization successful May 23 22:02:07 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:02:07 ppp [wan_link0] LCP: LayerUp May 23 22:02:07 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:02:07 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:02:07 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:02:07 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x548d3a6b May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] PROTOCOMP May 23 22:02:07 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:02:07 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x19dc65f6 May 23 22:02:07 ppp [wan_link0] AUTHPROTO PAP May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] LCP: SendConfigAck #164 May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x19dc65f6 May 23 22:02:07 ppp [wan_link0] AUTHPROTO PAP May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] LCP: rec'd Configure Request #164 (Req-Sent) May 23 22:02:07 ppp [wan_link0] MAGICNUM 0x548d3a6b May 23 22:02:07 ppp [wan_link0] MRU 1492 May 23 22:02:07 ppp [wan_link0] PROTOCOMP May 23 22:02:07 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:02:07 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:02:07 ppp [wan_link0] LCP: Up event May 23 22:02:07 ppp [wan_link0] Link: UP event May 23 22:02:07 ppp [wan_link0] PPPoE: connection successful May 23 22:02:07 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:02:06 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:02:06 ppp [wan_link0] LCP: LayerStart May 23 22:02:06 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:02:06 ppp [wan_link0] LCP: Open event May 23 22:02:06 ppp [wan_link0] Link: OPEN event May 23 22:02:06 ppp [wan] Bundle: Interface ng0 created May 23 22:02:06 ppp web: web is not running May 23 22:02:06 ppp process 19089 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:02:06 ppp Multi-link PPP daemon for FreeBSD May 23 22:02:02 ppp process 12700 terminated May 23 22:02:02 ppp [wan_link0] Link: Shutdown May 23 22:02:02 ppp [wan] Bundle: Shutdown May 23 22:02:00 ppp [wan_link0] LCP: Close event May 23 22:02:00 ppp [wan_link0] Link: CLOSE event May 23 22:02:00 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:02:00 ppp [wan_link0] LCP: LayerFinish May 23 22:02:00 ppp [wan_link0] LCP: Down event May 23 22:02:00 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:02:00 ppp [wan_link0] LCP: Close event May 23 22:02:00 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:02:00 ppp [wan_link0] Link: DOWN event May 23 22:02:00 ppp [wan_link0] PPPoE: connection closed May 23 22:02:00 ppp [wan_link0] LCP: LayerDown May 23 22:02:00 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:02:00 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:02:00 ppp [wan] IPV6CP: Down event May 23 22:02:00 ppp [wan] IPCP: state change Closed --> Initial May 23 22:02:00 ppp [wan] IPCP: Down event May 23 22:02:00 ppp [wan] IPV6CP: Close event May 23 22:02:00 ppp [wan] IPCP: Close event May 23 22:02:00 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:02:00 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:02:00 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:02:00 ppp [wan_link0] LCP: rec'd Terminate Request #74 (Opened) May 23 22:02:00 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:02:00 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:02:00 ppp [wan] IPCP: LayerFinish May 23 22:02:00 ppp [wan] IPCP: state change Closing --> Closed May 23 22:02:00 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:02:00 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:02:00 ppp [wan] IPV6CP: Close event May 23 22:02:00 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:02:00 ppp [wan] IFACE: Down event May 23 22:02:00 ppp [wan] IPCP: LayerDown May 23 22:02:00 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:02:00 ppp [wan] IPCP: state change Opened --> Closing May 23 22:02:00 ppp [wan] IPCP: Close event May 23 22:02:00 ppp [wan] IFACE: Close event May 23 22:02:00 ppp caught fatal signal TERM May 23 22:01:17 ppp [wan] IPV6CP: LayerFinish May 23 22:01:17 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:01:14 ppp [wan] IPV6CP: LayerDown May 23 22:01:14 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:01:14 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:01:14 ppp [wan] IPV6CP: rec'd Terminate Request #96 (Opened) May 23 22:01:14 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:01:14 ppp [wan] IPV6CP: LayerUp May 23 22:01:14 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:01:14 ppp [wan] IPV6CP: SendConfigAck #95 May 23 22:01:14 ppp [wan] IPV6CP: rec'd Configure Request #95 (Ack-Rcvd) May 23 22:01:14 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:01:14 ppp [wan] IFACE: Up event May 23 22:01:14 ppp [wan] 82.57.155.135 -> 192.168.100.1 May 23 22:01:14 ppp [wan] IPCP: LayerUp May 23 22:01:14 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:01:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:01:14 ppp [wan] IPCP: SendConfigAck #126 May 23 22:01:14 ppp [wan] 192.168.100.1 is OK May 23 22:01:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Request #126 (Ack-Rcvd) May 23 22:01:14 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:01:14 ppp [wan] IPADDR 82.57.155.135 May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:01:14 ppp [wan] IPADDR 82.57.155.135 May 23 22:01:14 ppp [wan] IPCP: SendConfigReq #3 May 23 22:01:14 ppp [wan] 82.57.155.135 is OK May 23 22:01:14 ppp [wan] IPADDR 82.57.155.135 May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:01:14 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:01:14 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:01:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:01:14 ppp [wan] IPCP: SendConfigReq #2 May 23 22:01:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:01:14 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:01:14 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:01:14 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:01:14 ppp [wan] IPV6CP: Up event May 23 22:01:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:01:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:01:14 ppp [wan] IPCP: SendConfigReq #1 May 23 22:01:14 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:01:14 ppp [wan] IPCP: Up event May 23 22:01:14 ppp [wan] IPV6CP: LayerStart May 23 22:01:14 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:01:14 ppp [wan] IPV6CP: Open event May 23 22:01:14 ppp [wan] IPCP: LayerStart May 23 22:01:14 ppp [wan] IPCP: state change Initial --> Starting May 23 22:01:14 ppp [wan] IPCP: Open event May 23 22:01:14 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:01:14 ppp [wan_link0] Link: Join bundle "wan" May 23 22:01:14 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:01:14 ppp [wan_link0] LCP: authorization successful May 23 22:01:14 ppp [wan_link0] MESG: REASON021 - TK MISSING: NOT IN DSL-LINE May 23 22:01:14 ppp [wan_link0] PAP: rec'd ACK #1 len: 44 May 23 22:01:14 ppp [wan_link0] LCP: LayerUp May 23 22:01:14 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:01:14 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:01:14 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:01:14 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:01:14 ppp [wan_link0] MAGICNUM 0xb8e86e4c May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] PROTOCOMP May 23 22:01:14 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:01:14 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:01:14 ppp [wan_link0] MAGICNUM 0x5e908b8b May 23 22:01:14 ppp [wan_link0] AUTHPROTO PAP May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] LCP: SendConfigAck #73 May 23 22:01:14 ppp [wan_link0] MAGICNUM 0x5e908b8b May 23 22:01:14 ppp [wan_link0] AUTHPROTO PAP May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] LCP: rec'd Configure Request #73 (Req-Sent) May 23 22:01:14 ppp [wan_link0] MAGICNUM 0xb8e86e4c May 23 22:01:14 ppp [wan_link0] MRU 1492 May 23 22:01:14 ppp [wan_link0] PROTOCOMP May 23 22:01:14 ppp [wan_link0] LCP: SendConfigReq #1 May 23 22:01:14 ppp [wan_link0] LCP: state change Starting --> Req-Sent May 23 22:01:14 ppp [wan_link0] LCP: Up event May 23 22:01:14 ppp [wan_link0] Link: UP event May 23 22:01:14 ppp [wan_link0] PPPoE: connection successful May 23 22:01:14 ppp PPPoE: rec'd ACNAME "r-rm900" May 23 22:01:14 ppp [wan_link0] PPPoE: Connecting to 'TelecomFibra' May 23 22:01:14 ppp [wan_link0] LCP: LayerStart May 23 22:01:14 ppp [wan_link0] LCP: state change Initial --> Starting May 23 22:01:14 ppp [wan_link0] LCP: Open event May 23 22:01:14 ppp [wan_link0] Link: OPEN event May 23 22:01:14 ppp [wan] Bundle: Interface ng0 created May 23 22:01:14 ppp web: web is not running May 23 22:01:14 ppp process 12700 started, version 5.8 (root@pfSense_v2_3_1_amd64-pfSense_v2_3_1-job-13 19:20 16-May-2016) May 23 22:01:14 ppp Multi-link PPP daemon for FreeBSD May 23 22:01:11 ppp process 29992 terminated May 23 22:01:11 ppp [wan_link0] Link: Shutdown May 23 22:01:11 ppp [wan] Bundle: Shutdown May 23 22:01:09 ppp [wan_link0] LCP: Close event May 23 22:01:09 ppp [wan_link0] Link: CLOSE event May 23 22:01:09 ppp [wan_link0] LCP: state change Closing --> Initial May 23 22:01:09 ppp [wan_link0] LCP: LayerFinish May 23 22:01:09 ppp [wan_link0] LCP: Down event May 23 22:01:09 ppp [wan_link0] LCP: state change Stopping --> Closing May 23 22:01:09 ppp [wan_link0] LCP: Close event May 23 22:01:09 ppp [wan_link0] Link: giving up after 0 reconnection attempts May 23 22:01:09 ppp [wan_link0] Link: DOWN event May 23 22:01:09 ppp [wan_link0] PPPoE: connection closed May 23 22:01:09 ppp [wan_link0] LCP: LayerDown May 23 22:01:09 ppp [wan_link0] LCP: SendTerminateAck #2 May 23 22:01:09 ppp [wan] IPV6CP: state change Closed --> Initial May 23 22:01:09 ppp [wan] IPV6CP: Down event May 23 22:01:09 ppp [wan] IPCP: state change Closed --> Initial May 23 22:01:09 ppp [wan] IPCP: Down event May 23 22:01:09 ppp [wan] IPV6CP: Close event May 23 22:01:09 ppp [wan] IPCP: Close event May 23 22:01:09 ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps May 23 22:01:09 ppp [wan_link0] Link: Leave bundle "wan" May 23 22:01:09 ppp [wan_link0] LCP: state change Opened --> Stopping May 23 22:01:09 ppp [wan_link0] LCP: rec'd Terminate Request #19 (Opened) May 23 22:01:09 ppp [wan] Bundle: closing link "wan_link0"... May 23 22:01:09 ppp [wan] Bundle: No NCPs left. Closing links... May 23 22:01:09 ppp [wan] IPCP: LayerFinish May 23 22:01:09 ppp [wan] IPCP: state change Closing --> Closed May 23 22:01:09 ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing) May 23 22:01:09 ppp [wan] IPV6CP: state change Stopped --> Closed May 23 22:01:09 ppp [wan] IPV6CP: Close event May 23 22:01:09 ppp [wan] IFACE: Rename interface pppoe1 to pppoe1 May 23 22:01:09 ppp [wan] IFACE: Down event May 23 22:01:09 ppp [wan] IPCP: LayerDown May 23 22:01:09 ppp [wan] IPCP: SendTerminateReq #4 May 23 22:01:09 ppp [wan] IPCP: state change Opened --> Closing May 23 22:01:09 ppp [wan] IPCP: Close event May 23 22:01:09 ppp [wan] IFACE: Close event May 23 22:01:09 ppp caught fatal signal TERM May 23 22:00:17 ppp [wan] IPV6CP: LayerFinish May 23 22:00:17 ppp [wan] IPV6CP: state change Stopping --> Stopped May 23 22:00:14 ppp [wan] IPV6CP: LayerDown May 23 22:00:14 ppp [wan] IPV6CP: SendTerminateAck #2 May 23 22:00:14 ppp [wan] IPV6CP: state change Opened --> Stopping May 23 22:00:14 ppp [wan] IPV6CP: rec'd Terminate Request #140 (Opened) May 23 22:00:14 ppp [wan] 76d4:35ff:fe8a:b19c -> 02a0:a50f:fc86:8004 May 23 22:00:14 ppp [wan] IPV6CP: LayerUp May 23 22:00:14 ppp [wan] IPV6CP: state change Ack-Rcvd --> Opened May 23 22:00:14 ppp [wan] IPV6CP: SendConfigAck #139 May 23 22:00:14 ppp [wan] IPV6CP: rec'd Configure Request #139 (Ack-Rcvd) May 23 22:00:14 ppp [wan] IFACE: Rename interface ng0 to pppoe1 May 23 22:00:14 ppp [wan] IFACE: Up event May 23 22:00:14 ppp [wan] 79.18.210.145 -> 192.168.100.1 May 23 22:00:14 ppp [wan] IPCP: LayerUp May 23 22:00:14 ppp [wan] IPCP: state change Ack-Rcvd --> Opened May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:00:14 ppp [wan] IPCP: SendConfigAck #11 May 23 22:00:14 ppp [wan] 192.168.100.1 is OK May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1 May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Request #11 (Ack-Rcvd) May 23 22:00:14 ppp [wan] IPCP: state change Req-Sent --> Ack-Rcvd May 23 22:00:14 ppp [wan] IPADDR 79.18.210.145 May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) May 23 22:00:14 ppp [wan] IPADDR 79.18.210.145 May 23 22:00:14 ppp [wan] IPCP: SendConfigReq #3 May 23 22:00:14 ppp [wan] 79.18.210.145 is OK May 23 22:00:14 ppp [wan] IPADDR 79.18.210.145 May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) May 23 22:00:14 ppp [wan] IPV6CP: state change Req-Sent --> Ack-Rcvd May 23 22:00:14 ppp [wan] IPV6CP: rec'd Configure Ack #1 (Req-Sent) May 23 22:00:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:00:14 ppp [wan] IPCP: SendConfigReq #2 May 23 22:00:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:00:14 ppp [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) May 23 22:00:14 ppp [wan] IPV6CP: SendConfigReq #1 May 23 22:00:14 ppp [wan] IPV6CP: state change Starting --> Req-Sent May 23 22:00:14 ppp [wan] IPV6CP: Up event May 23 22:00:14 ppp [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid May 23 22:00:14 ppp [wan] IPADDR 0.0.0.0 May 23 22:00:14 ppp [wan] IPCP: SendConfigReq #1 May 23 22:00:14 ppp [wan] IPCP: state change Starting --> Req-Sent May 23 22:00:14 ppp [wan] IPCP: Up event May 23 22:00:14 ppp [wan] IPV6CP: LayerStart May 23 22:00:14 ppp [wan] IPV6CP: state change Initial --> Starting May 23 22:00:14 ppp [wan] IPV6CP: Open event May 23 22:00:14 ppp [wan] IPCP: LayerStart May 23 22:00:14 ppp [wan] IPCP: state change Initial --> Starting May 23 22:00:14 ppp [wan] IPCP: Open event May 23 22:00:14 ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps May 23 22:00:14 ppp [wan_link0] Link: Join bundle "wan" May 23 22:00:14 ppp [wan_link0] Link: Matched action 'bundle "wan" ""' May 23 22:00:14 ppp [wan_link0] LCP: authorization successful May 23 22:00:14 ppp [wan_link0] PAP: rec'd ACK #1 len: 5 May 23 22:00:14 ppp [wan_link0] LCP: LayerUp May 23 22:00:14 ppp [wan_link0] PAP: sending REQUEST #1 len: 24 May 23 22:00:14 ppp [wan_link0] PAP: using authname "aliceadsl" May 23 22:00:14 ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing May 23 22:00:14 ppp [wan_link0] LCP: state change Ack-Sent --> Opened May 23 22:00:14 ppp [wan_link0] MAGICNUM 0x668d5328 May 23 22:00:14 ppp [wan_link0] MRU 1492 May 23 22:00:14 ppp [wan_link0] PROTOCOMP May 23 22:00:14 ppp [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) May 23 22:00:14 ppp [wan_link0] LCP: state change Req-Sent --> Ack-Sent May 23 22:00:14 ppp [wan_link0] MAGICNUM 0x534f4cbb May 23 22:00:14 ppp [wan_link0] AUTHPROTO PAP May 23 22:00:14 ppp [wan_link0] MRU 1492 May 23 22:00:14 ppp [wan_link0] LCP: SendConfigAck #18 May 23 22:00:14 ppp [wan_link0] MAGICNUM 0x534f4cbb
This seems ok (in the right order) :
May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177
May 23 22:11:26 ppp [wan] 87.21.211.177 is OK
You have your IPv4.
You're up.But then (in the right order) :
May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1
May 23 22:00:14 ppp [wan] 192.168.100.1 is OK
May 23 22:00:14 ppp [wan] IPCP: state change Ack-Rcvd –> Opened
May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1
May 23 22:00:14 ppp [wan] IPCP: SendConfigAck #11
May 23 22:00:14 ppp [wan] IPCP: LayerUp
May 23 22:00:14 ppp [wan] 79.18.210.145 -> 192.168.100.1
May 23 22:00:14 ppp [wan] IFACE: Up eventWhere does this local IP "192.168.100.1" coming from ?
Then the IPv6 starts to kick in.
Btw : aliceadsl (France) supports IPv6 ?
If so, deactivate IPv6, and try to get a good working IPv4 first. -
Same here. After upgrading there was no connection to the internet although ppp had a public ip address.
I have to disconnect and reconnect manually. This problem exists since 2.3.1 and is in most times reproducible after reboot.
Already made a clean install and restored config.
Using a vigor 130 for German adsl telekom. -
This seems ok (in the right order) :
May 23 22:11:26 ppp [wan] IPADDR 87.21.211.177
May 23 22:11:26 ppp [wan] 87.21.211.177 is OK
You have your IPv4.
You're up.But then (in the right order) :
May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1
May 23 22:00:14 ppp [wan] 192.168.100.1 is OK
May 23 22:00:14 ppp [wan] IPCP: state change Ack-Rcvd –> Opened
May 23 22:00:14 ppp [wan] IPADDR 192.168.100.1
May 23 22:00:14 ppp [wan] IPCP: SendConfigAck #11
May 23 22:00:14 ppp [wan] IPCP: LayerUp
May 23 22:00:14 ppp [wan] 79.18.210.145 -> 192.168.100.1
May 23 22:00:14 ppp [wan] IFACE: Up eventWhere does this local IP "192.168.100.1" coming from ?
Then the IPv6 starts to kick in.
Btw : aliceadsl (France) supports IPv6 ?
If so, deactivate IPv6, and try to get a good working IPv4 first.192.168.100.1 is the modem. I have a IPv6 tunnel with Hurricane Electric. I try only IPv4 with a fresh install, same problem with PPPoe. AliceADSL is by TIM Italy (VDSL 100Mb/s).
-
Same here. After upgrading there was no connection to the internet although ppp had a public ip address.
I have to disconnect and reconnect manually. This problem exists since 2.3.1 and is in most times reproducible after reboot.
Already made a clean install and restored config.
Using a vigor 130 for German adsl telekom.Yes, the same happens to my config. But i have problem since 2.3.0 and then 2.3.1. If i disconnect/reconnect 4/5 times, then WAN PPPoe goes up with internet connection.
-
Yesterday i tried another PC with 2 Reltek interface and pfSense 2.3.2 (0528). Same PPPoe on WAN (Telecom Fibra 100Mb/s), same PPPoE error: WAN get dynamic IP from ISP, gateway monitor show WAN gateway down, no internet connection. :-[
Instead, the other firewall with 2.3.1 crashed after running for 3 days. This time disconnect/connect WAN interface doesn't solve problem. Too much problems for now with 2.3.x with PPPoE, rollback on 2.2.6.
There's is any news from pfSense team about this issue?
-
New test with 2.2.6, 2.3.1 and 2.3.2 (snapshot 05312016) and two different hardware (my ITX firewall and Alix 2D). I tried with two different italian ISP with PPPoE connection and modem in bridge mode.
With 2.2.6 pfSense works without any kind of problem: WAN public IP is assigned fron ISP, on gateway widget PPPoE connection on WAN is green. Internet and outboud traffic works normally.
With 2.3.1 and 2.3.2 both ITX and Alix get IP address from ISP, but gateway widget show PPPoE WAN down. No internet outbound traffic and outbound PING. Disconnect and reconnect WAN interface works only some times.
I don't know what other kind of test i can do… I like very much new 2.3 pfSense, but i cannot install on my system. :'(
-
Ran into the same problem yesterday when I did the 2.3.2 upgrade.
It gets a ip on the wan connection but the gateway itself is down.Connected to it remotely using openvpn worked fine….
Ended up reverting to a previous 2.2.6 snapshot and it worked straight away.Also tried doing a fresh install of 2.3.2 same problem appeared same as OP
Ps on Uk BT ppoe
-
Yes, it seems the same error. I'd like to know if pfSense Team can open a bug about this issue.
-
Same problem here.
Alix motherboard and bridged modem, all ok with 2.3.0 but after upgrading to 2.3.1 no more internet access.
If I go to Status->Interfaces and I do a disconnect and the a connect internet is ok.It's surely a bug within version 2.3.1 and hope it will be solved soon.
-
I have been poking around this on the most weird ways using two pfSense installs running on VMware. One being the server and another the client. The only way I found to make it work was to do the following.
-
Edit WAN_PPPOE gateway using 'System > Routing > Gateways > Edit'
1.1) Check 'Use non-local gateway' on advanced options
1.2) Save & Apply -
Edit WAN using 'Interfaces > WAN'
2.1) Add the WAN interface MAC address manually
2.2) Save & Apply
Then after a system reboot, everything magically worked.
-
-
Hi Jeorge, thank you for your post. I'll try tomorrow and let you know if it works. :)
EDIT: try your config. No luck, same error. :(