pfsense dropping pppoe connection multiple times an hour

phildean66 · May 15, 2023, 5:27 AM

Netgate pfSense Plus
23.01-RELEASE (amd64)
built on Fri Feb 10 20:06:33 UTC 2023
FreeBSD 14.0-CURRENT

rcoleman-netgate · May 15, 2023, 4:31 PM

Install the System Patches package and then install all the recommended updates (System->Patches) and then reboot. See if that resolves your PPPoE issue.

stephenw10 · May 15, 2023, 10:31 PM

What do you see in the ppp log when it disconnects?

biggsy · May 15, 2023, 11:18 PM

@phildean66 said in pfsense dropping pppoe connection multiple times an hour:

TPG is my Provider for NBN

VLAN for PPPoE (re0.10) which from managed switch is untagged to NBN

Don't TPG still use PPPoE over VLAN 10?

Try including the managed switch to NBN modem link in VLAN 10.

phildean66 · May 15, 2023, 11:48 PM

@biggsy

TPG don't use a VLAN normally to NBN as every other setup I used previously I never configured a vlan on I've only done it on the pfsense setup as I have 1 network connection and had to limit the traffic on the LAN,

pfsense on my managed switch in port 47 has vlan 10 tagged and vlan 1 native and port 48 which is going to NBN has only vlan 10 and it's set as native so no tag appears.

phildean66 · May 16, 2023, 12:01 AM

@stephenw10

May 14 17:51:00 InternetRouter newsyslog[88128]: logfile turned over due to size>500K
May 14 17:51:44 InternetRouter ppp[38689]: caught fatal signal TERM
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IFACE: Close event
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IPCP: Close event
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IPCP: state change Opened --> Closing
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IPCP: SendTerminateReq #4
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IPCP: LayerDown
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IFACE: Removing IPv4 address from pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Can't assign requested address
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IFACE: Down event
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IFACE: Rename interface pppoe0 to pppoe0
May 14 17:51:44 InternetRouter ppp[38689]: [wan] IFACE: Set description "WAN"
May 14 17:51:46 InternetRouter ppp[38689]: [wan] IPCP: SendTerminateReq #5
May 14 17:51:46 InternetRouter ppp[38689]: [wan_link0] rec'd unexpected protocol IP
May 14 17:51:46 InternetRouter ppp[38689]: [wan] Bundle: Shutdown
May 14 17:51:46 InternetRouter ppp[38689]: [wan_link0] Link: Shutdown
May 14 17:51:46 InternetRouter ppp[38689]: process 38689 terminated
May 14 17:51:48 InternetRouter ppp[34046]: Multi-link PPP daemon for FreeBSD
May 14 17:51:48 InternetRouter ppp[34046]:  
May 14 17:51:48 InternetRouter ppp[34046]: process 34046 started, version 5.9
May 14 17:51:48 InternetRouter ppp[34046]: web: web is not running
May 14 17:51:48 InternetRouter ppp[34046]: [wan] Bundle: Interface ng0 created
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] Link: OPEN event
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: Open event
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: state change Initial --> Starting
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: LayerStart
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] PPPoE: Connecting to ''
May 14 17:51:48 InternetRouter ppp[34046]: PPPoE: rec'd ACNAME "syd-gls-har-bras202"
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] PPPoE: connection successful
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] Link: UP event
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: Up event
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: state change Starting --> Req-Sent
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: SendConfigReq #1
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   PROTOCOMP
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MRU 1492
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MAGICNUM 0x59ecda42
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MRU 1492
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   AUTHPROTO PAP
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MAGICNUM 0xedb80d55
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: SendConfigAck #1
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MRU 1492
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   AUTHPROTO PAP
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MAGICNUM 0xedb80d55
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   PROTOCOMP
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MRU 1492
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0]   MAGICNUM 0x59ecda42
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: state change Ack-Sent --> Opened
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: auth: peer wants PAP, I want nothing
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] PAP: using authname "phildean66"
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] PAP: sending REQUEST #1 len: 30
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: LayerUp
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] PAP: rec'd ACK #1 len: 5
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] LCP: authorization successful
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] Link: Matched action 'bundle "wan" ""'
May 14 17:51:48 InternetRouter ppp[34046]: [wan_link0] Link: Join bundle "wan"
May 14 17:51:48 InternetRouter ppp[34046]: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: Open event
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: state change Initial --> Starting
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: LayerStart
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: Up event
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: state change Starting --> Req-Sent
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: SendConfigReq #1
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   IPADDR 0.0.0.0
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   PRIDNS 0.0.0.0
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   SECDNS 0.0.0.0
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   IPADDR 10.20.25.233
May 14 17:51:48 InternetRouter ppp[34046]: [wan]     10.20.25.233 is OK
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: SendConfigAck #1
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   IPADDR 10.20.25.233
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: state change Req-Sent --> Ack-Sent
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: SendConfigReq #2
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   IPADDR 0.0.0.0
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   PRIDNS 0.0.0.0
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   SECDNS 0.0.0.0
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   IPADDR 27.32.227.81
May 14 17:51:48 InternetRouter ppp[34046]: [wan]     27.32.227.81 is OK
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   PRIDNS 203.12.160.35
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   SECDNS 203.12.160.36
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: SendConfigReq #3
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   IPADDR 27.32.227.81
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   PRIDNS 203.12.160.35
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   SECDNS 203.12.160.36
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   IPADDR 27.32.227.81
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   PRIDNS 203.12.160.35
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   SECDNS 203.12.160.36
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: state change Ack-Sent --> Opened
May 14 17:51:48 InternetRouter ppp[34046]: [wan] IPCP: LayerUp
May 14 17:51:48 InternetRouter ppp[34046]: [wan]   27.32.227.81 -> 10.20.25.233
May 14 17:51:49 InternetRouter ppp[34046]: [wan] IFACE: Up event
May 14 17:51:49 InternetRouter ppp[34046]: [wan] IFACE: Rename interface ng0 to pppoe0
May 14 17:51:49 InternetRouter ppp[34046]: [wan] IFACE: Add description "WAN"
May 14 17:54:13 InternetRouter ppp[34046]: caught fatal signal TERM
May 14 17:54:13 InternetRouter ppp[34046]: [wan] IFACE: Close event
May 14 17:54:13 InternetRouter ppp[34046]: [wan] IPCP: Close event
May 14 17:54:13 InternetRouter ppp[34046]: [wan] IPCP: state change Opened --> Closing
May 14 17:54:13 InternetRouter ppp[34046]: [wan] IPCP: SendTerminateReq #4
May 14 17:54:13 InternetRouter ppp[34046]: [wan] IPCP: LayerDown
May 14 17:54:14 InternetRouter ppp[34046]: [wan] IFACE: Removing IPv4 address from pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Can't assign requested address
May 14 17:54:14 InternetRouter ppp[34046]: [wan] IFACE: Down event
May 14 17:54:14 InternetRouter ppp[34046]: [wan] IFACE: Rename interface pppoe0 to pppoe0
May 14 17:54:14 InternetRouter ppp[34046]: [wan] IFACE: Set description "WAN"
May 14 17:54:15 InternetRouter ppp[34046]: [wan] IPCP: SendTerminateReq #5
May 14 17:54:16 InternetRouter ppp[34046]: [wan] Bundle: Shutdown
May 14 17:54:16 InternetRouter ppp[34046]: [wan_link0] Link: Shutdown
May 14 17:54:16 InternetRouter ppp[34046]: process 34046 terminated
May 14 17:54:17 InternetRouter ppp[50581]: Multi-link PPP daemon for FreeBSD
May 14 17:54:17 InternetRouter ppp[50581]:  
May 14 17:54:17 InternetRouter ppp[50581]: process 50581 started, version 5.9
May 14 17:54:17 InternetRouter ppp[50581]: web: web is not running
May 14 17:54:17 InternetRouter ppp[50581]: [wan] Bundle: Interface ng0 created
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] Link: OPEN event
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: Open event
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: state change Initial --> Starting
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: LayerStart
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] PPPoE: Connecting to ''
May 14 17:54:17 InternetRouter ppp[50581]: PPPoE: rec'd ACNAME "syd-gls-har-bras216"
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] PPPoE: connection successful
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] Link: UP event
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: Up event
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: state change Starting --> Req-Sent
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: SendConfigReq #1
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   PROTOCOMP
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MRU 1492
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MAGICNUM 0xea778695
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MRU 1492
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   AUTHPROTO PAP
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MAGICNUM 0x8b847bde
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: SendConfigAck #1
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MRU 1492
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   AUTHPROTO PAP
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MAGICNUM 0x8b847bde
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   PROTOCOMP
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MRU 1492
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0]   MAGICNUM 0xea778695
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: state change Ack-Sent --> Opened
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: auth: peer wants PAP, I want nothing
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] PAP: using authname "phildean66"
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] PAP: sending REQUEST #1 len: 30
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: LayerUp
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] PAP: rec'd ACK #1 len: 5
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] LCP: authorization successful
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] Link: Matched action 'bundle "wan" ""'
May 14 17:54:17 InternetRouter ppp[50581]: [wan_link0] Link: Join bundle "wan"
May 14 17:54:17 InternetRouter ppp[50581]: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: Open event
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: state change Initial --> Starting
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: LayerStart
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: Up event
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: state change Starting --> Req-Sent
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: SendConfigReq #1
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   IPADDR 0.0.0.0
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   PRIDNS 0.0.0.0
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   SECDNS 0.0.0.0
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   IPADDR 10.20.26.66
May 14 17:54:17 InternetRouter ppp[50581]: [wan]     10.20.26.66 is OK
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: SendConfigAck #1
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   IPADDR 10.20.26.66
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: state change Req-Sent --> Ack-Sent
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: SendConfigReq #2
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   IPADDR 0.0.0.0
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   PRIDNS 0.0.0.0
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   SECDNS 0.0.0.0
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   IPADDR 194.193.223.8
May 14 17:54:17 InternetRouter ppp[50581]: [wan]     194.193.223.8 is OK
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   PRIDNS 203.12.160.35
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   SECDNS 203.12.160.36
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: SendConfigReq #3
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   IPADDR 194.193.223.8
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   PRIDNS 203.12.160.35
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   SECDNS 203.12.160.36
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   IPADDR 194.193.223.8
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   PRIDNS 203.12.160.35
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   SECDNS 203.12.160.36
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: state change Ack-Sent --> Opened
May 14 17:54:17 InternetRouter ppp[50581]: [wan] IPCP: LayerUp
May 14 17:54:17 InternetRouter ppp[50581]: [wan]   194.193.223.8 -> 10.20.26.66
May 14 17:54:18 InternetRouter ppp[50581]: [wan] IFACE: Up event
May 14 17:54:18 InternetRouter ppp[50581]: [wan] IFACE: Rename interface ng0 to pppoe0
May 14 17:54:18 InternetRouter ppp[50581]: [wan] IFACE: Add description "WAN"
May 14 18:07:18 InternetRouter ppp[50581]: caught fatal signal TERM
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IFACE: Close event
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IPCP: Close event
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IPCP: state change Opened --> Closing
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IPCP: SendTerminateReq #4
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IPCP: LayerDown
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IFACE: Removing IPv4 address from pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Can't assign requested address
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IFACE: Down event
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IFACE: Rename interface pppoe0 to pppoe0
May 14 18:07:18 InternetRouter ppp[50581]: [wan] IFACE: Set description "WAN"
May 14 18:07:20 InternetRouter ppp[50581]: [wan] IPCP: SendTerminateReq #5
May 14 18:07:20 InternetRouter ppp[50581]: [wan] Bundle: Shutdown
May 14 18:07:20 InternetRouter ppp[50581]: [wan_link0] Link: Shutdown
May 14 18:07:20 InternetRouter ppp[50581]: process 50581 terminated
May 14 18:07:22 InternetRouter ppp[56557]: Multi-link PPP daemon for FreeBSD
May 14 18:07:22 InternetRouter ppp[56557]:  
May 14 18:07:22 InternetRouter ppp[56557]: process 56557 started, version 5.9
May 14 18:07:22 InternetRouter ppp[56557]: web: web is not running
May 14 18:07:22 InternetRouter ppp[56557]: [wan] Bundle: Interface ng0 created
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] Link: OPEN event
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: Open event
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: state change Initial --> Starting
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: LayerStart
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] PPPoE: Connecting to ''
May 14 18:07:22 InternetRouter ppp[56557]: PPPoE: rec'd ACNAME "syd-gls-har-bras210"
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] PPPoE: connection successful
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] Link: UP event
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: Up event
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: state change Starting --> Req-Sent
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: SendConfigReq #1
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   PROTOCOMP
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MRU 1492
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MAGICNUM 0x97455f6c
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MRU 1492
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   AUTHPROTO PAP
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MAGICNUM 0xfbbed935
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: SendConfigAck #1
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MRU 1492
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   AUTHPROTO PAP
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MAGICNUM 0xfbbed935
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   PROTOCOMP
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MRU 1492
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0]   MAGICNUM 0x97455f6c
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: state change Ack-Sent --> Opened
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: auth: peer wants PAP, I want nothing
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] PAP: using authname "phildean66"
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] PAP: sending REQUEST #1 len: 30
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: LayerUp
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] PAP: rec'd ACK #1 len: 5
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] LCP: authorization successful
May 14 18:07:22 InternetRouter ppp[56557]: [wan_link0] Link: Matched action 'bundle "wan" ""'

stephenw10 · May 16, 2023, 12:03 AM

@phildean66 said in pfsense dropping pppoe connection multiple times an hour:

May 14 17:54:18 InternetRouter ppp[50581]: [wan] IFACE: Add description "WAN"
May 14 18:07:18 InternetRouter ppp[50581]: caught fatal signal TERM

Ok so what happens between those logs? Something is shutting down the mpd service.
Anything in the system log at those times?

biggsy · May 16, 2023, 12:21 AM

TPG don't use a VLAN normally to NBN

I was working from memory there. Actually, it's VLAN 2 that TPG expects. For example, see this recent post on Whirlpool.

If you had been using TPG-supplied routers, the VLAN would have been preconfigured. Not sure about the ER but easy enough to check.

BTW, I assume you realise that, with only one network port on the NUC, you will be sharing its 1Gb/s bandwidth between LAN and WAN - limiting your Ultrafast download.

USB/ethernet adapters are not normally recommended here.

phildean66 · May 16, 2023, 12:26 AM

@stephenw10
Had to fine some system log entries later abut they sort of maked with entries later in the ppp log. timeing of last couple in that ppp log were 9:54 then 9:58

May 15 09:56:00 InternetRouter newsyslog[23884]: logfile turned over due to size>500K
May 15 09:56:00 InternetRouter sshguard[67459]: Exiting on signal.
May 15 09:56:00 InternetRouter sshguard[24901]: Now monitoring attacks.
May 15 09:58:17 InternetRouter check_reload_status[398]: Linkup starting re0
May 15 09:58:17 InternetRouter kernel: re0: watchdog timeout
May 15 09:58:17 InternetRouter kernel: re0: link state changed to DOWN
May 15 09:58:17 InternetRouter kernel: re0.10: link state changed to DOWN
May 15 09:58:17 InternetRouter check_reload_status[398]: Linkup starting re0.10
May 15 09:58:18 InternetRouter php-fpm[360]: /rc.linkup: Hotplug event detected for LAN(lan) static IP address (4: 192.168.58.1)
May 15 09:58:18 InternetRouter php-fpm[360]: /rc.linkup: DEVD Ethernet detached event for lan
May 15 09:58:18 InternetRouter check_reload_status[398]: Reloading filter
May 15 09:58:18 InternetRouter ppp[90871]: caught fatal signal TERM
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IFACE: Close event
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IPCP: Close event
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IPCP: state change Opened --> Closing
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IPCP: SendTerminateReq #4
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IPCP: LayerDown
May 15 09:58:18 InternetRouter check_reload_status[398]: Rewriting resolv.conf
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IFACE: Removing IPv4 address from pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Can't assign requested address
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IFACE: Down event
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IFACE: Rename interface pppoe0 to pppoe0
May 15 09:58:18 InternetRouter ppp[90871]: [wan] IFACE: Set description "WAN"
May 15 09:58:20 InternetRouter ppp[90871]: [wan] IPCP: SendTerminateReq #5
May 15 09:58:20 InternetRouter check_reload_status[398]: Reloading filter
May 15 09:58:20 InternetRouter ppp[90871]: [wan] Bundle: Shutdown
May 15 09:58:20 InternetRouter ppp[90871]: [wan_link0] Link: Shutdown
May 15 09:58:20 InternetRouter ppp[90871]: process 90871 terminated
May 15 09:58:21 InternetRouter check_reload_status[398]: Linkup starting re0
May 15 09:58:21 InternetRouter kernel: re0: link state changed to UP
May 15 09:58:21 InternetRouter kernel: re0.10: link state changed to UP
May 15 09:58:21 InternetRouter check_reload_status[398]: Linkup starting re0.10
May 15 09:58:22 InternetRouter php-fpm[78214]: /rc.linkup: Hotplug event detected for LAN(lan) static IP address (4: 192.168.58.1)
May 15 09:58:22 InternetRouter php-fpm[78214]: /rc.linkup: DEVD Ethernet attached event for lan
May 15 09:58:22 InternetRouter php-fpm[78214]: /rc.linkup: HOTPLUG: Triggering address refresh on lan (re0)
May 15 09:58:22 InternetRouter check_reload_status[398]: rc.newwanip starting re0
May 15 09:58:22 InternetRouter check_reload_status[398]: Reloading filter
May 15 09:58:22 InternetRouter ppp[337]: Multi-link PPP daemon for FreeBSD
May 15 09:58:22 InternetRouter ppp[337]:
May 15 09:58:22 InternetRouter ppp[337]: process 337 started, version 5.9
May 15 09:58:22 InternetRouter ppp[337]: web: web is not running
May 15 09:58:22 InternetRouter ppp[337]: [wan] Bundle: Interface ng0 created
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] Link: OPEN event
May 15 09:58:22 InternetRouter kernel: ng0: changing name to 'pppoe0'
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: Open event
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: state change Initial --> Starting
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: LayerStart
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] PPPoE: Connecting to ''
May 15 09:58:22 InternetRouter ppp[337]: PPPoE: rec'd ACNAME "syd-gls-har-bras207"
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] PPPoE: connection successful
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] Link: UP event
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: Up event
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: state change Starting --> Req-Sent
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: SendConfigReq #1
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] PROTOCOMP
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MRU 1492
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MAGICNUM 0x4edb5c49
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
May 15 09:58:22 InternetRouter kernel: ng_pppoe[13]: no matching session
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MRU 1492
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] AUTHPROTO PAP
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MAGICNUM 0x42079fd4
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: SendConfigAck #1
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MRU 1492
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] AUTHPROTO PAP
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MAGICNUM 0x42079fd4
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] PROTOCOMP
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MRU 1492
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] MAGICNUM 0x4edb5c49
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: state change Ack-Sent --> Opened
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: auth: peer wants PAP, I want nothing
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] PAP: using authname "phildean66"
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] PAP: sending REQUEST #1 len: 30
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: LayerUp
May 15 09:58:22 InternetRouter kernel: ng_pppoe[13]: no matching session
May 15 09:58:22 InternetRouter kernel: ng_pppoe[13]: no matching session
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] PAP: rec'd ACK #1 len: 5
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] LCP: authorization successful
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] Link: Matched action 'bundle "wan" ""'
May 15 09:58:22 InternetRouter ppp[337]: [wan_link0] Link: Join bundle "wan"
May 15 09:58:22 InternetRouter ppp[337]: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: Open event
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: state change Initial --> Starting
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: LayerStart
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: Up event
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: state change Starting --> Req-Sent
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: SendConfigReq #1
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPADDR 0.0.0.0
May 15 09:58:22 InternetRouter ppp[337]: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 15 09:58:22 InternetRouter ppp[337]: [wan] PRIDNS 0.0.0.0
May 15 09:58:22 InternetRouter ppp[337]: [wan] SECDNS 0.0.0.0
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPADDR 10.20.22.186
May 15 09:58:22 InternetRouter ppp[337]: [wan] 10.20.22.186 is OK
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: SendConfigAck #1
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPADDR 10.20.22.186
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: state change Req-Sent --> Ack-Sent
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
May 15 09:58:22 InternetRouter ppp[337]: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: SendConfigReq #2
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPADDR 0.0.0.0
May 15 09:58:22 InternetRouter ppp[337]: [wan] PRIDNS 0.0.0.0
May 15 09:58:22 InternetRouter ppp[337]: [wan] SECDNS 0.0.0.0
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPADDR 220.244.130.233
May 15 09:58:22 InternetRouter ppp[337]: [wan] 220.244.130.233 is OK
May 15 09:58:22 InternetRouter ppp[337]: [wan] PRIDNS 203.12.160.35
May 15 09:58:22 InternetRouter ppp[337]: [wan] SECDNS 203.12.160.36
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: SendConfigReq #3
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPADDR 220.244.130.233
May 15 09:58:22 InternetRouter ppp[337]: [wan] PRIDNS 203.12.160.35
May 15 09:58:22 InternetRouter ppp[337]: [wan] SECDNS 203.12.160.36
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPADDR 220.244.130.233
May 15 09:58:22 InternetRouter ppp[337]: [wan] PRIDNS 203.12.160.35
May 15 09:58:22 InternetRouter ppp[337]: [wan] SECDNS 203.12.160.36
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: state change Ack-Sent --> Opened
May 15 09:58:22 InternetRouter ppp[337]: [wan] IPCP: LayerUp
May 15 09:58:22 InternetRouter ppp[337]: [wan] 220.244.130.233 -> 10.20.22.186
May 15 09:58:22 InternetRouter check_reload_status[398]: Rewriting resolv.conf
May 15 09:58:23 InternetRouter php-fpm[78214]: /rc.newwanip: rc.newwanip: Info: starting on re0.
May 15 09:58:23 InternetRouter php-fpm[78214]: /rc.newwanip: rc.newwanip: on (IP address: 192.168.58.1) (interface: LAN[lan]) (real interface: re0).
May 15 09:58:23 InternetRouter check_reload_status[398]: rc.newwanip starting pppoe0
May 15 09:58:23 InternetRouter ppp[337]: [wan] IFACE: Up event
May 15 09:58:23 InternetRouter ppp[337]: [wan] IFACE: Rename interface ng0 to pppoe0
May 15 09:58:23 InternetRouter ppp[337]: [wan] IFACE: Add description "WAN"
May 15 09:58:24 InternetRouter php-fpm[78214]: /rc.newwanip: Default gateway setting Interface WAN_PPPOE Gateway as default.
May 15 09:58:24 InternetRouter php-fpm[78214]: /rc.newwanip: Resyncing OpenVPN instances for interface LAN.
May 15 09:58:24 InternetRouter php-fpm[78214]: /rc.newwanip: Creating rrd update script
May 15 09:58:24 InternetRouter php-fpm[31578]: /rc.newwanip: rc.newwanip: Info: starting on pppoe0.
May 15 09:58:24 InternetRouter php-fpm[31578]: /rc.newwanip: rc.newwanip: on (IP address: 220.244.130.233) (interface: WAN[wan]) (real interface: pppoe0).
May 15 09:58:25 InternetRouter php-fpm[31578]: /rc.newwanip: IP Address has changed, killing states on former IP Address 182.239.138.49.
May 15 09:58:25 InternetRouter php-fpm[31578]: /rc.newwanip: Resyncing OpenVPN instances for interface WAN.
May 15 09:58:25 InternetRouter php-fpm[31578]: /rc.newwanip: Creating rrd update script
May 15 09:58:25 InternetRouter check_reload_status[398]: Restarting IPsec tunnels
May 15 09:58:25 InternetRouter check_reload_status[398]: updating dyndns wan
May 15 09:58:25 InternetRouter check_reload_status[398]: Reloading filter
May 15 09:58:26 InternetRouter php-fpm[78214]: /rc.newwanip: Netgate pfSense Plus package system has detected an IP change or dynamic WAN reconnection - 192.168.58.1 -> 192.168.58.1 - Restarting packages.
May 15 09:58:26 InternetRouter check_reload_status[398]: Starting packages
May 15 09:58:26 InternetRouter check_reload_status[398]: Reloading filter
May 15 09:58:27 InternetRouter php-fpm[78214]: /rc.start_packages: Restarting/Starting all packages.
May 15 09:58:27 InternetRouter php-fpm[31578]: /rc.newwanip: Netgate pfSense Plus package system has detected an IP change or dynamic WAN reconnection - 182.239.138.49 -> 220.244.130.233 - Restarting packages.
May 15 09:58:27 InternetRouter check_reload_status[398]: Starting packages
May 15 09:58:27 InternetRouter check_reload_status[398]: Reloading filter
May 15 09:58:28 InternetRouter php-fpm[359]: /rc.start_packages: Restarting/Starting all packages.
May 15 09:59:00 InternetRouter sshguard[24901]: Exiting on signal.
May 15 09:59:00 InternetRouter sshguard[41230]: Now monitoring attacks.
May 15 10:15:56 InternetRouter login[84648]: login on ttyv0 as root
May 15 10:16:54 InternetRouter ppp[337]: [wan_link0] LCP: no reply to 1 echo request(s)

phildean66 · May 16, 2023, 4:33 AM

@biggsy

Yeah I know.

standard basic setup wizard used on the ER so I know there was no VLAN, currently ER has been up for 22hr on the WAN connection since I swapped it back in yesterday until I can work out the issue with this.

I don't have another device I can try for this setup yet.

biggsy · May 16, 2023, 4:33 AM

@phildean66

Sorry, out of ideas there except maybe trying VLAN 2 is worth a go.

Have to say, my experience with TPG a few years ago put me right off ever dealing with them again.

stephenw10 · May 16, 2023, 3:33 PM

@phildean66 said in pfsense dropping pppoe connection multiple times an hour:

May 15 09:58:17 InternetRouter kernel: re0: watchdog timeout
May 15 09:58:17 InternetRouter kernel: re0: link state changed to DOWN
May 15 09:58:17 InternetRouter kernel: re0.10: link state changed to DOWN
May 15 09:58:17 InternetRouter check_reload_status[398]: Linkup starting re0.10

This is usually a sign you need to be using the alternative Realtek driver. You mentioned above you were going to try it but I assume you have not yet.

Using any other type of NIC instead is preferable though. (Except USB! )

Steve

phildean66 · May 16, 2023, 3:33 PM

@stephenw10

I have loaded up 197 driver and will see how that goes.