Gateway alarm: WAN_PPPOE
-
any idea why i keep getting the gateway alarm?
Thanks
PaulFeb 28 14:25:53 dpinger 51689 send_interval 500ms loss_interval 2000ms time_period 60000ms report_interval 0ms data_len 1 alert_interval 1000ms latency_alarm 500ms loss_alarm 20% dest_addr 10.12.12.14 bind_addr 12.34.56.78 identifier "WAN_PPPOE "
Wan dropping.txt -
@wheelhouse20
Obviously your WAN PPPoE is unstable.
Could be the hardware like cable or modem.What kind of connection is this?
-
@viragomann the wan is connected to a ztlink mt992.
-
@wheelhouse20
So it's probably a DSL connection.What shows Status > interfaces > WAN?
Do you have access to a log file of the modem? If so, check if the DSL connection went down.
-
@viragomann ztlink mt992 modem dont give out info. my connection is Gfast.
https://www.thinkbroadband.com/broadband/monitoring/quality/share/4b2c345cf4383d79b99aff29793e2c9eb3e44a8c-27-02-2022
https://www.thinkbroadband.com/broadband/monitoring/quality/share/cf6757946802c9bcb9d362083565b5642d5c2fd6 -
@wheelhouse20 said in Gateway alarm: WAN_PPPOE:
Feb 28 14:25:53 dpinger 51689 send_interval 500ms loss_interval 2000ms time_period 60000ms report_interval 0ms data_len 1 alert_interval 1000ms latency_alarm 500ms loss_alarm 20% dest_addr 10.12.12.14 bind_addr 12.34.56.78 identifier "WAN_PPPOE "
That's not a gateway alarm. That's a log from dpinger starting showing it's config on that interface.
An alarm looks like:
Feb 28 07:16:44 rc.gateway_alarm 19336 >>> Gateway alarm: WAN_PPPOE (Addr:10.12.12.14 Alarm:1 RTT:19.163ms RTTsd:.325ms Loss:21%)
Shown there because the packet loss went over the 20% threshold set when it started.
And there it's because the PPPoE failed:
Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: state change Opened --> Stopping Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: peer not responding to echo requests Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: no reply to 5 echo request(s) Feb 28 07:17:22 ppp 9483 [wan_link0] LCP: no reply to 4 echo request(s) Feb 28 07:17:11 ppp 9483 [wan_link0] LCP: no reply to 3 echo request(s) Feb 28 07:17:01 ppp 9483 [wan_link0] LCP: no reply to 2 echo request(s) Feb 28 07:16:51 ppp 9483 [wan_link0] LCP: no reply to 1 echo request(s)
Nothing pfSense can do if it fails at the LCP layer. So it kills tje old connections and starts trying to reconnect. And about 30s later it does:
Feb 28 07:18:01 ppp 9483 [wan] IFACE: Add description "WAN" Feb 28 07:18:01 ppp 9483 [wan] IFACE: Rename interface ng0 to pppoe0 Feb 28 07:18:01 ppp 9483 [wan] IFACE: Up event Feb 28 07:18:01 check_reload_status 409 rc.newwanip starting pppoe0 Feb 28 07:18:01 ppp 9483 [wan] 12.34.56.78 -> 10.12.12.14 Feb 28 07:18:01 ppp 9483 [wan] IPCP: LayerUp Feb 28 07:18:01 ppp 9483 [wan] IPCP: state change Ack-Sent --> Opened Feb 28 07:18:01 ppp 9483 [wan] IPADDR 12.34.56.78
Then later it fails for the same reason. Probably a bad line card or something upstream.
I would suggest trying a different modem but those are like gold dust. I know!I would change the gateway monitoring IP to something upstream of the gateway, like 8.8.8.8. That will give you a far better idea of the actual connection quality.
What sort of connection speeds do you see? Are you toward the maximum distance for g.fast?Steve
-
@stephenw10
The internet was fine for a about 4-5 days then pfblocker updated then the gateway alarm came at the end. Im about 110 meters from the cabinet and my max speed are 310-down 48-up, i pay for 330-down 48-up. the modem was installed by bt-openreachand id rather not pay for a replacement right now.
i have changed from 1.1.1.3 to 8.8.8.8.Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: peer not responding to echo requests Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: no reply to 5 echo request(s) Feb 28 07:17:22 ppp 9483 [wan_link0] LCP: no reply to 4 echo request(s) Feb 28 07:17:11 ppp 9483 [wan_link0] LCP: no reply to 3 echo request(s) Feb 28 07:17:01 ppp 9483 [wan_link0] LCP: no reply to 2 echo request(s) Feb 28 07:16:51 ppp 9483 [wan_link0] LCP: no reply to 1 echo request(s) Feb 28 07:16:45 php-fpm 370 /rc.openvpn: Gateway, none 'available' for inet6, use the first one configured. '' Feb 28 07:16:45 php-fpm 370 /rc.openvpn: Gateway, none 'available' for inet, use the first one configured. 'WAN_PPPOE' Feb 28 07:16:44 check_reload_status 409 Reloading filter Feb 28 07:16:44 check_reload_status 409 Restarting OpenVPN tunnels/interfaces Feb 28 07:16:44 check_reload_status 409 Restarting IPsec tunnels Feb 28 07:16:44 check_reload_status 409 updating dyndns WAN_PPPOE Feb 28 07:16:44 rc.gateway_alarm 19336 >>> Gateway alarm: WAN_PPPOE (Addr:10.12.12.14 Alarm:1 RTT:19.163ms RTTsd:.325ms Loss:21%) Feb 28 07:02:00 sshguard 69726 Now monitoring attacks. Feb 28 07:02:00 sshguard 49987 Exiting on signal. Feb 28 07:00:00 php 96239 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 07:00:00 php 96239 [pfBlockerNG] Starting cron process. Feb 28 06:00:00 php 50130 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 06:00:00 php 50130 [pfBlockerNG] Starting cron process. Feb 28 05:00:00 php 75827 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 05:00:00 php 75827 [pfBlockerNG] Starting cron process. Feb 28 04:00:00 php 7032 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 04:00:00 php 7032 [pfBlockerNG] Starting cron process. Feb 28 03:00:00 php 29155 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 03:00:00 php 29155 [pfBlockerNG] Starting cron process. Feb 28 02:00:00 php 57649 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 02:00:00 php 57649 [pfBlockerNG] Starting cron process. Feb 28 01:06:00 sshguard 49987 Now monitoring attacks. Feb 28 01:06:00 sshguard 8869 Exiting on signal. Feb 28 01:00:00 php 82674 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 01:00:00 php 82674 [pfBlockerNG] Starting cron process. Feb 28 00:00:36 php 68430 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 00:00:00 php 68430 [pfBlockerNG] Starting cron process. Feb 27 23:00:00 php 92181 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 27 23:00:00 php 92181 [pfBlockerNG] Starting cron process. Feb 27 22:00:00 php 23443 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 27 22:00:00 php 23443 [pfBlockerNG] Starting cron process. Feb 27 21:00:00 php 9357 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 27 21:00:00 php 9357 [pfBlockerNG] Starting cron process. Feb 27 20:02:00 sshguard 8869 Now monitoring attacks. Feb 27 20:02:00 sshguard 99989 Exiting on signal. Feb 27 20:00:00 php 37363 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 27 20:00:00 php 37363 [pfBlockerNG] Starting cron process.
-
@wheelhouse20 said in Gateway alarm: WAN_PPPOE:
Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: peer not responding to echo requests
Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: no reply to 5 echo request(s)
Feb 28 07:17:22 ppp 9483 [wan_link0] LCP: no reply to 4 echo request(s)Hi, this indicates a Provider Problem and not a Gateway issue ... IMHO (could be a Modem Problem too)
regards,
fireodo -
@fireodo
This dosent indicate any thing as it take time to reconnect after losing the connection.
also im looking for why the connect lost if the fist place ie pfblocker/rc.update_urltables.Feb 28 12:38:42 ppp 9483 [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps Feb 28 12:38:42 ppp 9483 [wan_link0] Link: Leave bundle "wan" Feb 28 12:38:42 ppp 9483 [wan_link0] LCP: state change Opened --> Stopping Feb 28 12:38:42 ppp 9483 [wan_link0] LCP: peer not responding to echo requests Feb 28 12:38:42 ppp 9483 [wan_link0] LCP: no reply to 5 echo request(s) Feb 28 12:38:32 ppp 9483 [wan_link0] LCP: no reply to 4 echo request(s) Feb 28 12:38:22 ppp 9483 [wan_link0] LCP: no reply to 3 echo request(s) Feb 28 12:38:12 ppp 9483 [wan_link0] LCP: no reply to 2 echo request(s) Feb 28 12:38:02 ppp 9483 [wan_link0] LCP: no reply to 1 echo request(s) Feb 28 12:37:55 php-fpm 370 /rc.openvpn: Gateway, none 'available' for inet6, use the first one configured. '' Feb 28 12:37:55 php-fpm 370 /rc.openvpn: Gateway, none 'available' for inet, use the first one configured. 'WAN_PPPOE' Feb 28 12:37:54 check_reload_status 409 Reloading filter Feb 28 12:37:54 check_reload_status 409 Restarting OpenVPN tunnels/interfaces Feb 28 12:37:54 check_reload_status 409 Restarting IPsec tunnels Feb 28 12:37:54 check_reload_status 409 updating dyndns WAN_PPPOE Feb 28 12:37:54 rc.gateway_alarm 13430 >>> Gateway alarm: WAN_PPPOE (Addr:10.12.12.14 Alarm:1 RTT:18.385ms RTTsd:.317ms Loss:22%) Feb 28 12:30:59 php 56119 rc.update_urltables: /etc/rc.update_urltables: pfB_PRI3_v4 does not need updating. Feb 28 12:30:59 php 56119 rc.update_urltables: /etc/rc.update_urltables: pfB_PRI4_v4 does not need updating. Feb 28 12:30:59 php 56119 rc.update_urltables: /etc/rc.update_urltables: pfB_PRI5_v4 does not need updating. Feb 28 12:30:59 php 56119 rc.update_urltables: /etc/rc.update_urltables: pfB_PRI1_v4 does not need updating. Feb 28 12:30:59 php 56119 rc.update_urltables: /etc/rc.update_urltables: pfB_Europe_v6 does not need updating. Feb 28 12:30:59 php 56119 rc.update_urltables: /etc/rc.update_urltables: pfB_Europe_v4 does not need updating. Feb 28 12:30:59 php 56119 rc.update_urltables: /etc/rc.update_urltables: Starting URL table alias updates Feb 28 12:30:00 php 56119 rc.update_urltables: /etc/rc.update_urltables: Sleeping for 59 seconds. Feb 28 12:30:00 php 56119 rc.update_urltables: /etc/rc.update_urltables: Starting up. Feb 28 12:00:00 php 54612 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 12:00:00 php 54612 [pfBlockerNG] Starting cron process. Feb 28 11:00:00 php 72144 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 11:00:00 php 72144 [pfBlockerNG] Starting cron process. Feb 28 10:00:00 php 10495 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 10:00:00 php 10495 [pfBlockerNG] Starting cron process. Feb 28 09:00:00 php 38311 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 09:00:00 php 38311 [pfBlockerNG] Starting cron process. Feb 28 08:00:00 php 13474 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 08:00:00 php 13474 [pfBlockerNG] Starting cron process.
Feb 28 07:17:32 ppp 9483 [wan_link0] Link: Leave bundle "wan" Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: state change Opened --> Stopping Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: peer not responding to echo requests Feb 28 07:17:32 ppp 9483 [wan_link0] LCP: no reply to 5 echo request(s) Feb 28 07:17:22 ppp 9483 [wan_link0] LCP: no reply to 4 echo request(s) Feb 28 07:17:11 ppp 9483 [wan_link0] LCP: no reply to 3 echo request(s) Feb 28 07:17:01 ppp 9483 [wan_link0] LCP: no reply to 2 echo request(s) Feb 28 07:16:51 ppp 9483 [wan_link0] LCP: no reply to 1 echo request(s) Feb 28 07:16:45 php-fpm 370 /rc.openvpn: Gateway, none 'available' for inet6, use the first one configured. '' Feb 28 07:16:45 php-fpm 370 /rc.openvpn: Gateway, none 'available' for inet, use the first one configured. 'WAN_PPPOE' Feb 28 07:16:44 check_reload_status 409 Reloading filter Feb 28 07:16:44 check_reload_status 409 Restarting OpenVPN tunnels/interfaces Feb 28 07:16:44 check_reload_status 409 Restarting IPsec tunnels Feb 28 07:16:44 check_reload_status 409 updating dyndns WAN_PPPOE Feb 28 07:16:44 rc.gateway_alarm 19336 >>> Gateway alarm: WAN_PPPOE (Addr:10.12.12.14 Alarm:1 RTT:19.163ms RTTsd:.325ms Loss:21%) Feb 28 07:02:00 sshguard 69726 Now monitoring attacks. Feb 28 07:02:00 sshguard 49987 Exiting on signal. Feb 28 07:00:00 php 96239 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 07:00:00 php 96239 [pfBlockerNG] Starting cron process. Feb 28 06:00:00 php 50130 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 06:00:00 php 50130 [pfBlockerNG] Starting cron process. Feb 28 05:00:00 php 75827 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 05:00:00 php 75827 [pfBlockerNG] Starting cron process. Feb 28 04:00:00 php 7032 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 04:00:00 php 7032 [pfBlockerNG] Starting cron process. Feb 28 03:00:00 php 29155 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 03:00:00 php 29155 [pfBlockerNG] Starting cron process. Feb 28 02:00:00 php 57649 [pfBlockerNG] No changes to Firewall rules, skipping Filter Reload Feb 28 02:00:00 php 57649 [pfBlockerNG] Starting cron process.
-
@stephenw10 said in Gateway alarm: WAN_PPPOE:
I would suggest trying a different modem but those are like gold dust. I know!
That seems to hit the bull's eye here.
@wheelhouse20 said in Gateway alarm: WAN_PPPOE:
also im looking for why the connect lost if the fist place ie pfblocker/rc.update_urltables.
I cannot see any relation with pfBlockerNG in the logs.
-
@wheelhouse20 said in Gateway alarm: WAN_PPPOE:
modem was installed by bt-openreach
Lucky, they'd stopped giving those out by the time I got g.fast.
Yeah, this is nothing to do with pfBlocker updates.
The remote side of the DSL stops responding to LCP 15mins after the update.
There's nothing pfSense can do about that except kill the ppp session and start over.Steve
-
@wheelhouse20 You're experiencing the same dpinger issue...I get those alarms as well. Here is snapshot last time mine happened:
Clear latency 8561us stddev 5618us loss 15%
Feb 23 09:04:51 dpinger 55934 WAN_DHCP xx.xxx.xxx.1: Alarm latency 11829us stddev 8213us loss 21%
Feb 23 09:05:17 dpinger 55934 WAN_DHCP xx.xxx.xxx.1: Clear latency 11452us stddev 8133us loss 20%
Feb 23 09:05:31 dpinger 55934 WAN_DHCP xx.xxx.xxx.1: Alarm latency 10222us stddev 6298us loss 21%
Feb 23 09:05:48 dpinger 55934 WAN_DHCP xx.xxx.xxx.1: Clear latency 8644us stddev 5458us loss 14%
Feb 23 10:04:10 dpinger 55934 WAN_DHCP xx.xxx.xxx.1: Alarm latency 9920us stddev 6204us loss 21%
Feb 23 10:05:20 dpinger 55934 WAN_DHCP xx.xxx.xxx.1: Clear latency 8879us stddev 4871us loss 20% -
That's a different cause though since you're using DHCP and this is a failure at the LCP level.
-
Dpinger
Dpinger.txt -
This post is deleted! -
@stephenw10 said in Gateway alarm: WAN_PPPOE:
That's a different cause though since you're using DHCP and this is a failure at the LCP level.
Okay.
-
my WAN has been UP for 4 days then get an rc.gateway_alarm again must be something todo with with dpinger.
Mar 9 20:29:02 rc.gateway_alarm 70547 >>> Gateway alarm: WAN_PPPOE (Addr:15.14.12.10 Alarm:1 RTT:7.122ms RTTsd:.307ms Loss:21%)
-
@wheelhouse20 said in Gateway alarm: WAN_PPPOE:
Loss:21%
Yup, the default packet loss alarm threshold is 20% so it should throw an alarm when it hits 21%. We can see from previous logs that you have not changed it from that default so that's correct.
I would expect to probably see the same LCP echo timeouts in the ppp log?
I note the mt992 g.fast modem seems to have got a lot cheaper since I bought one. I think I paid well north of £100 at the time.
So if you are seeing LCP issues you might consider swapping it out but it's probably an upsteam issue. Either way there nothing pfSense can do there except restart the connection process.
Steve
-
@stephenw10 what was i ment to change ?
-
I was suggesting you might change the modem if you can find one cheap enough. There have been some MT992s sold on ebay for <£20 recently. However I still think this is an upstream issue and that probably won't help.
Steve