PPPoE connection issues

Started by nadorcs, January 28, 2025, 03:18:35 PM

Previous topic - Next topic
Print
Go Down Pages1 2
User actions
January 28, 2025, 03:18:35 PM
Hi,

I am new to opnsense and encountered some issues with PPPoE.
I mostly followed Home Network Guy's tutorial (https://homenetworkguy.com/how-to/set-up-a-fully-functioning-home-network-using-opnsense/).
I run opnsense in a proxmox VE. The local networks seem to function as they are supposed to, but the WAN-PPPoE part doesn't.

My ISP provides an ONT/router, which can work as a router or as a simple ONT (bridge mode). At the moment I connect to it with a very old PC (debian, 15+ years old hardware) that does basic routing. The PPPoE connection was established with pppoeconf, and works. Only username and password is needed.

At the interfaces/wan menu I can set up basic PPPoE config. It also creates PPP device. See the screenshots.
I noticed, that in the older version of opnsense, there was an "IPv4 upstream gateway: auto-detect" menu item/option. That no longer exists. When I checked the system/gateways/configuration part, I could see no gateways added. So I tried enabling the dynamic gateway policy option for WAN. That created two gateway rules, but did not solved the issue. I am not sure if I am supposed to have this option enbabled.
 
I also seem to lack a default route. So I tried adding a default route for 0.0.0.0/32 toward WAN_PPPOE - inet. I am again not sure if I should have this, nevertheless it did not change my issue.

I presume the 11th paragraph of "read this first" topic is for me. I have the outbound NAT rule as "generate automatically" per https://docs.opnsense.org/manual/nat.html#outbound as I have only one external IP. I am not sure how I should configure a virtual IP.

In the PPPS log file I found an interesting line:
Code Select
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="80"] [wan] IFACE: Adding IPv4 address to pppoe0 failed: File exists
If someone more experienced with opnsense could take a look, I would appreciate.

You can see more screenshots and the log file at the link below:
log and screenshots
January 28, 2025, 03:46:32 PM #1
Did you disable "hardware checksum offload" in Interfaces: Settings?

The Gateway is added automatically by the PPP server. Check Interfaces: Overview to verify.
January 28, 2025, 04:05:56 PM #2 Last Edit: January 28, 2025, 04:19:33 PM by nadorcs
yes, all hardware acceleration is disabled.
I do not see any gateways - but that might be because the ppp link is not established - as linking it to WAN fails (edit: more precisely: the received PPPoE IP address can not be set - but my understanding is that the WAN interface should get the IP via PPPoE). you can see the interfaces overview at link in the original post.
January 28, 2025, 04:20:04 PM #3
What are your local subnets?
Maybe something is conflicting.
January 28, 2025, 04:27:02 PM #4
hardware --- proxmox bridge --- opnsense
enp2s0f1 --- vmbr0 --- vtnet1 [LAN 10.0.0.1/24]
enp2s0f0 --- vmbr1 --- vtnet0 [WAN / pppoe]
enp3s0 --- vmbr2 --- vtnet2 [szomszed 10.0.1.1/24]
---------------------vlan01 [vendeg 10.0.2.1/24] tag: 10 parent:vtnet1
January 28, 2025, 04:34:17 PM #5
Quote from: nadorcs on January 28, 2025, 04:27:02 PMenp2s0f1 --- vmbr0 --- vtnet1 [LAN 10.0.0.1/24]

You have to change this to something else.
The PPP server tries to assign 10.0.0.1 as gateway. But this is conflicting with your local subnet.
January 28, 2025, 04:39:52 PM #6
OK. I will give it a try. But that means I need to change the addresses of most of my devices  - proxmox, Open Media Vault, managed switch, and all the computers...

Why does the PPP server try to do this? In my current debian firewall there seems to be no such conflict.
January 28, 2025, 04:48:16 PM #7
That's really bad.

Quote from: nadorcs on January 28, 2025, 04:39:52 PMIn my current debian firewall there seems to be no such conflict.
And you used 10.0.0.1/24 as well in your local subnet?

The operating system should not have any impact on the gateway. It's given by the ISP:

Quote<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="56"] [wan] IPCP: SendConfigReq #1
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="57"] [wan]   IPADDR 0.0.0.0
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="58"] [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="59"] [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="60"] [wan]   IPADDR 10.0.0.1
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="61"] [wan]     10.0.0.1 is OK
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="62"] [wan] IPCP: SendConfigAck #1
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="63"] [wan]   IPADDR 10.0.0.1
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="64"] [wan] IPCP: state change Req-Sent --> Ack-Sent
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="65"] [wan_link0] rec'd unexpected protocol IPV6CP, rejecting
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="66"] [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="67"] [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="68"] [wan] IPCP: SendConfigReq #2
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="69"] [wan]   IPADDR 0.0.0.0
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="70"] [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="71"] [wan]   IPADDR 85.66.43.79
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="72"] [wan]     85.66.43.79 is OK
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="73"] [wan] IPCP: SendConfigReq #3
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="74"] [wan]   IPADDR 85.66.43.79
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="75"] [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="76"] [wan]   IPADDR 85.66.43.79
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="77"] [wan] IPCP: state change Ack-Sent --> Opened
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="78"] [wan] IPCP: LayerUp
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="79"] [wan]   85.66.43.79 -> 10.0.0.1
<30>1 2025-01-28T13:47:25+01:00 Tuzfal.nador.net ppp 40834 - [meta sequenceId="80"] [wan] IFACE: Adding IPv4 address to pppoe0 failed: File exists

The log shows, you got 85.66.43.79 as your WAN IP and 10.0.0.1 as upstream gateway.
January 28, 2025, 04:54:06 PM #8
yes. my pc's local address at the moment is 10.0.0.4. The subnets are the same, except there is no vlan at current system. The firewall is a basic debian pc, and I used shorewall to set up some simple rules.
January 28, 2025, 05:40:43 PM #9
I tried a different subnet. Partial success: there seems to be a successful connection, which is lost immediately - "too many sessions".

Code Select
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="1"] Multi-link PPP daemon for FreeBSD
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="2"] 
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="3"] process 6937 started, version 5.9
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="4"] web: web is not running
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="5"] [wan] Bundle: Interface ng0 created
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="6"] [wan_link0] Link: OPEN event
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="7"] [wan_link0] LCP: Open event
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="8"] [wan_link0] LCP: state change Initial --> Starting
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="9"] [wan_link0] LCP: LayerStart
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="10"] [wan_link0] PPPoE: Connecting to ''
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="11"] PPPoE: rec'd ACNAME "DIGI"
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="12"] [wan_link0] PPPoE: connection successful
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="13"] [wan_link0] Link: UP event
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="14"] [wan_link0] LCP: Up event
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="15"] [wan_link0] LCP: state change Starting --> Req-Sent
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="16"] [wan_link0] LCP: SendConfigReq #1
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="17"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="18"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="19"] [wan_link0]   MAGICNUM 0xf4c93f2f
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="20"] [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="21"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="22"] [wan_link0]   AUTHPROTO PAP
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="23"] [wan_link0]   MAGICNUM 0xb81ce90b
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="24"] [wan_link0] LCP: SendConfigAck #1
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="25"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="26"] [wan_link0]   AUTHPROTO PAP
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="27"] [wan_link0]   MAGICNUM 0xb81ce90b
<30>1 2025-01-28T17:14:58+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="28"] [wan_link0] LCP: state change Req-Sent --> Ack-Sent
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="29"] [wan_link0] LCP: SendConfigReq #2
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="30"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="31"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="32"] [wan_link0]   MAGICNUM 0xf4c93f2f
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="33"] [wan_link0] LCP: rec'd Configure Reject #2 (Ack-Sent)
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="34"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="35"] [wan_link0] LCP: SendConfigReq #3
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="36"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="37"] [wan_link0]   MAGICNUM 0xf4c93f2f
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="38"] [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent)
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="39"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="40"] [wan_link0]   MAGICNUM 0xf4c93f2f
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="41"] [wan_link0] LCP: state change Ack-Sent --> Opened
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="42"] [wan_link0] LCP: auth: peer wants PAP, I want nothing
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="43"] [wan_link0] PAP: using authname "nadorgeza-5cp"
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="44"] [wan_link0] PAP: sending REQUEST #1 len: 27
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="45"] [wan_link0] LCP: LayerUp
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="46"] [wan_link0] PAP: rec'd NAK #1 len: 23
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="47"] [wan_link0]   MESG: Too many sessions
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="48"] [wan_link0] LCP: authorization failed
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="49"] [wan_link0] LCP: parameter negotiation failed
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="50"] [wan_link0] LCP: state change Opened --> Stopping
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="51"] [wan_link0] LCP: SendTerminateReq #4
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="52"] [wan_link0] LCP: LayerDown
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="53"] [wan_link0] LCP: rec'd Terminate Request #2 (Stopping)
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="54"] [wan_link0] LCP: SendTerminateAck #5
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="55"] [wan_link0] LCP: rec'd Terminate Ack #4 (Stopping)
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="56"] [wan_link0] LCP: state change Stopping --> Stopped
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="57"] [wan_link0] LCP: LayerFinish
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="58"] [wan_link0] PPPoE: connection closed
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="59"] [wan_link0] Link: DOWN event
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="60"] [wan_link0] LCP: Down event
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="61"] [wan_link0] LCP: state change Stopped --> Starting
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="62"] [wan_link0] LCP: LayerStart
<30>1 2025-01-28T17:15:00+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="63"] [wan_link0] Link: reconnection attempt 1 in 3 seconds
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="1"] [wan_link0] Link: reconnection attempt 1
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="2"] [wan_link0] PPPoE: Connecting to ''
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="3"] PPPoE: rec'd ACNAME "DIGI"
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="4"] [wan_link0] PPPoE: connection successful
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="5"] [wan_link0] Link: UP event
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="6"] [wan_link0] LCP: Up event
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="7"] [wan_link0] LCP: state change Starting --> Req-Sent
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="8"] [wan_link0] LCP: SendConfigReq #6
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="9"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="10"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="11"] [wan_link0]   MAGICNUM 0x386e3ca6
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="12"] [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="13"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="14"] [wan_link0]   AUTHPROTO PAP
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="15"] [wan_link0]   MAGICNUM 0x989ab5d6
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="16"] [wan_link0] LCP: SendConfigAck #1
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="17"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="18"] [wan_link0]   AUTHPROTO PAP
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="19"] [wan_link0]   MAGICNUM 0x989ab5d6
<30>1 2025-01-28T17:15:03+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="20"] [wan_link0] LCP: state change Req-Sent --> Ack-Sent
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="21"] [wan_link0] LCP: SendConfigReq #7
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="22"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="23"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="24"] [wan_link0]   MAGICNUM 0x386e3ca6
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="25"] [wan_link0] LCP: rec'd Configure Reject #7 (Ack-Sent)
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="26"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="27"] [wan_link0] LCP: SendConfigReq #8
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="28"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="29"] [wan_link0]   MAGICNUM 0x386e3ca6
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="30"] [wan_link0] LCP: rec'd Configure Ack #8 (Ack-Sent)
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="31"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="32"] [wan_link0]   MAGICNUM 0x386e3ca6
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="33"] [wan_link0] LCP: state change Ack-Sent --> Opened
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="34"] [wan_link0] LCP: auth: peer wants PAP, I want nothing
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="35"] [wan_link0] PAP: using authname "nadorgeza-5cp"
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="36"] [wan_link0] PAP: sending REQUEST #1 len: 27
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="37"] [wan_link0] LCP: LayerUp
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="38"] [wan_link0] PAP: rec'd NAK #1 len: 23
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="39"] [wan_link0]   MESG: Too many sessions
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="40"] [wan_link0] LCP: authorization failed
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="41"] [wan_link0] LCP: parameter negotiation failed
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="42"] [wan_link0] LCP: state change Opened --> Stopping
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="43"] [wan_link0] LCP: SendTerminateReq #9
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="44"] [wan_link0] LCP: LayerDown
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="45"] [wan_link0] LCP: rec'd Terminate Request #2 (Stopping)
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="46"] [wan_link0] LCP: SendTerminateAck #10
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="47"] [wan_link0] LCP: rec'd Terminate Ack #9 (Stopping)
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="48"] [wan_link0] LCP: state change Stopping --> Stopped
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="49"] [wan_link0] LCP: LayerFinish
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="50"] [wan_link0] PPPoE: connection closed
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="51"] [wan_link0] Link: DOWN event
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="52"] [wan_link0] LCP: Down event
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="53"] [wan_link0] LCP: state change Stopped --> Starting
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="54"] [wan_link0] LCP: LayerStart
<30>1 2025-01-28T17:15:05+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="55"] [wan_link0] Link: reconnection attempt 2 in 4 seconds
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="56"] [wan_link0] Link: reconnection attempt 2
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="57"] [wan_link0] PPPoE: Connecting to ''
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="58"] PPPoE: rec'd ACNAME "DIGI"
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="59"] [wan_link0] PPPoE: connection successful
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="60"] [wan_link0] Link: UP event
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="61"] [wan_link0] LCP: Up event
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="62"] [wan_link0] LCP: state change Starting --> Req-Sent
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="63"] [wan_link0] LCP: SendConfigReq #11
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="64"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="65"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="66"] [wan_link0]   MAGICNUM 0xf5fc0066
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="67"] [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="68"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="69"] [wan_link0]   AUTHPROTO PAP
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="70"] [wan_link0]   MAGICNUM 0xd9f20bce
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="71"] [wan_link0] LCP: SendConfigAck #1
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="72"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="73"] [wan_link0]   AUTHPROTO PAP
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="74"] [wan_link0]   MAGICNUM 0xd9f20bce
<30>1 2025-01-28T17:15:09+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="75"] [wan_link0] LCP: state change Req-Sent --> Ack-Sent
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="76"] [wan_link0] LCP: SendConfigReq #12
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="77"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="78"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="79"] [wan_link0]   MAGICNUM 0xf5fc0066
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="80"] [wan_link0] LCP: rec'd Configure Reject #12 (Ack-Sent)
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="81"] [wan_link0]   PROTOCOMP
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="82"] [wan_link0] LCP: SendConfigReq #13
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="83"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="84"] [wan_link0]   MAGICNUM 0xf5fc0066
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="85"] [wan_link0] LCP: rec'd Configure Ack #13 (Ack-Sent)
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="86"] [wan_link0]   MRU 1492
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="87"] [wan_link0]   MAGICNUM 0xf5fc0066
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="88"] [wan_link0] LCP: state change Ack-Sent --> Opened
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="89"] [wan_link0] LCP: auth: peer wants PAP, I want nothing
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="90"] [wan_link0] PAP: using authname "nadorgeza-5cp"
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="91"] [wan_link0] PAP: sending REQUEST #1 len: 27
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="92"] [wan_link0] LCP: LayerUp
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="93"] [wan_link0] PAP: rec'd NAK #1 len: 23
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="94"] [wan_link0]   MESG: Too many sessions
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="95"] [wan_link0] LCP: authorization failed
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="96"] [wan_link0] LCP: parameter negotiation failed
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="97"] [wan_link0] LCP: state change Opened --> Stopping
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="98"] [wan_link0] LCP: SendTerminateReq #14
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="99"] [wan_link0] LCP: LayerDown
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="100"] [wan_link0] LCP: rec'd Terminate Request #2 (Stopping)
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="101"] [wan_link0] LCP: SendTerminateAck #15
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="102"] [wan_link0] LCP: rec'd Terminate Ack #14 (Stopping)
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="103"] [wan_link0] LCP: state change Stopping --> Stopped
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="104"] [wan_link0] LCP: LayerFinish
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="105"] [wan_link0] PPPoE: connection closed
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="106"] [wan_link0] Link: DOWN event
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="107"] [wan_link0] LCP: Down event
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="108"] [wan_link0] LCP: state change Stopped --> Starting
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="109"] [wan_link0] LCP: LayerStart
<30>1 2025-01-28T17:15:11+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="110"] [wan_link0] Link: reconnection attempt 3 in 1 seconds
<30>1 2025-01-28T17:15:12+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="111"] [wan_link0] Link: reconnection attempt 3
<30>1 2025-01-28T17:15:12+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="112"] [wan_link0] PPPoE: Connecting to ''
<30>1 2025-01-28T17:15:21+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="113"] [wan_link0] PPPoE connection timeout after 9 seconds
<30>1 2025-01-28T17:15:21+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="114"] [wan_link0] Link: DOWN event
<30>1 2025-01-28T17:15:21+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="115"] [wan_link0] LCP: Down event
<30>1 2025-01-28T17:15:21+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="116"] [wan_link0] Link: reconnection attempt 4 in 1 seconds
<30>1 2025-01-28T17:15:22+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="117"] [wan_link0] Link: reconnection attempt 4
<30>1 2025-01-28T17:15:22+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="118"] [wan_link0] PPPoE: Connecting to ''
<30>1 2025-01-28T17:15:31+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="119"] [wan_link0] PPPoE connection timeout after 9 seconds
<30>1 2025-01-28T17:15:31+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="120"] [wan_link0] Link: DOWN event
<30>1 2025-01-28T17:15:31+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="121"] [wan_link0] LCP: Down event
<30>1 2025-01-28T17:15:31+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="122"] [wan_link0] Link: reconnection attempt 5 in 4 seconds
<30>1 2025-01-28T17:15:35+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="123"] [wan_link0] Link: reconnection attempt 5
<30>1 2025-01-28T17:15:35+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="124"] [wan_link0] PPPoE: Connecting to ''
<30>1 2025-01-28T17:15:44+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="125"] [wan_link0] PPPoE connection timeout after 9 seconds
<30>1 2025-01-28T17:15:44+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="126"] [wan_link0] Link: DOWN event
<30>1 2025-01-28T17:15:44+01:00 Tuzfal.nador.net ppp 6937 - [meta sequenceId="127"] [wan_link0] LCP: Down event
interfaces overview in the screenshot. I updated the log file at the drive as well.
January 28, 2025, 06:03:37 PM #10
Seems the ISP don't let you in anymore.
I guess "Too many sessions" relates to the number of PPPoE sessions you your ISP, maybe due to different MAC address.

Maybe this times out automatically, or you have to call your ISP.
January 28, 2025, 07:32:08 PM #11
Yes, I just needed to wait a bit...

I also needed to apply 2 default routes - are those OK?

Thanks for the help!

With such nice people around here I will have to donate to opnsense...
January 28, 2025, 08:42:45 PM #12
Since the ISP pushes the upstream gateway, I'd expect that the routes are set automatically.
If so it is shown in Interfaces: Overview, as mentioned above.

Also you can check the routing table in Interfaces: Diagnostic.
January 30, 2025, 05:40:00 PM #13
Without adding the default routes manually I can not reach anything on the internet even from the firewall. With the manually added routes everything seems to work as it should. I could not find the routing table at Interfaces:Diagnostic. Is it a change in the GUI or maybe I just do not know what to look for?
January 30, 2025, 05:44:19 PM #14
I was wrong. The routes can be found in System: Routes: Status.
Print
Go Up Pages1 2
User actions