Menu

Show posts

This section allows you to view all posts made by this member. Note that you can only see posts made in areas you currently have access to.

Show posts Menu

Messages - chris42

#16
Hi there,

after some time my connectivity gets lost. I need to then connect via serial console and reload all services. When doing so the box crashes with a panic.
After rebooting, I get a crash reporter offering me to send a report. However the report contains quite a bit personal information. So where is this send to? Any open space, like forum or github issue?

Kind regards
  Christian
#17
Yes, patch was working tonight in one single cron job, so far no issues. Definitely applied the cron table, as I changed it multiple times yesterday for testing.
#18
Nothing in my logs, however I have the patch installed. I assume this would only occur without the patch?
#19
Quote from: franco on February 02, 2022, 01:31:55 PM
"DEVD" events from system log would be most helpful.

Hmm... a grep for "DEVD" on my latest log in /var/log/system does not find anything. Do I need to up some logging levels somewhere?
#20
Quote from: franco on February 02, 2022, 12:38:01 PM
Still missing the system log here.

Any specifics to look out for in the system.log?

The patch seems to work. Below the log from the cron triggered disconnect.


2022-02-02T13:15:38 Informational ppp [wan]   <IP> -> <IP>
2022-02-02T13:15:38 Informational ppp [wan] IPCP: LayerUp
2022-02-02T13:15:38 Informational ppp [wan] IPCP: state change Ack-Sent --> Opened
2022-02-02T13:15:38 Informational ppp [wan]   IPADDR <IP>
2022-02-02T13:15:38 Informational ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
2022-02-02T13:15:38 Informational ppp [wan]   IPADDR <IP>
2022-02-02T13:15:38 Informational ppp [wan] IPCP: SendConfigReq #3
2022-02-02T13:15:38 Informational ppp [wan]     <IP> is OK
2022-02-02T13:15:38 Informational ppp [wan]   IPADDR <IP>
2022-02-02T13:15:38 Informational ppp [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
2022-02-02T13:15:38 Informational ppp [wan] IFACE: Rename interface ng0 to pppoe1
2022-02-02T13:15:38 Informational ppp [wan] IFACE: Up event
2022-02-02T13:15:37 Informational ppp [wan]   <IPv6> -> <IPv6>
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: LayerUp
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: state change Ack-Sent --> Opened
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: rec'd Configure Ack #1 (Ack-Sent)
2022-02-02T13:15:37 Informational ppp [wan]   IPADDR 0.0.0.0
2022-02-02T13:15:37 Informational ppp [wan] IPCP: SendConfigReq #2
2022-02-02T13:15:37 Informational ppp [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
2022-02-02T13:15:37 Informational ppp [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: state change Req-Sent --> Ack-Sent
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: SendConfigAck #1
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: rec'd Configure Request #1 (Req-Sent)
2022-02-02T13:15:37 Informational ppp [wan] IPCP: state change Req-Sent --> Ack-Sent
2022-02-02T13:15:37 Informational ppp [wan]   IPADDR <IP>
2022-02-02T13:15:37 Informational ppp [wan] IPCP: SendConfigAck #1
2022-02-02T13:15:37 Informational ppp [wan]     <IP> is OK
2022-02-02T13:15:37 Informational ppp [wan]   IPADDR <IP>
2022-02-02T13:15:37 Informational ppp [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: SendConfigReq #1
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: state change Starting --> Req-Sent
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: Up event
2022-02-02T13:15:37 Informational ppp [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
2022-02-02T13:15:37 Informational ppp [wan]   IPADDR 0.0.0.0
2022-02-02T13:15:37 Informational ppp [wan] IPCP: SendConfigReq #1
2022-02-02T13:15:37 Informational ppp [wan] IPCP: state change Starting --> Req-Sent
2022-02-02T13:15:37 Informational ppp [wan] IPCP: Up event
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: LayerStart
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: state change Initial --> Starting
2022-02-02T13:15:37 Informational ppp [wan] IPV6CP: Open event
2022-02-02T13:15:37 Informational ppp [wan] IPCP: LayerStart
2022-02-02T13:15:37 Informational ppp [wan] IPCP: state change Initial --> Starting
2022-02-02T13:15:37 Informational ppp [wan] IPCP: Open event
2022-02-02T13:15:37 Informational ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
2022-02-02T13:15:37 Informational ppp [wan_link0] Link: Join bundle "wan"
2022-02-02T13:15:37 Informational ppp [wan_link0] Link: Matched action 'bundle "wan" ""'
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: authorization successful
2022-02-02T13:15:37 Informational ppp [wan_link0]   MESG: [UI-SBR:55040,11136;UI-LINEID:1UND1.DEU.DTAG.CX6JK;]
2022-02-02T13:15:37 Informational ppp [wan_link0] PAP: rec'd ACK #1 len: 57
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: LayerUp
2022-02-02T13:15:37 Informational ppp [wan_link0] PAP: sending REQUEST #1 len: 52
2022-02-02T13:15:37 Informational ppp [wan_link0] PAP: using authname "***********"
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: state change Ack-Rcvd --> Opened
2022-02-02T13:15:37 Informational ppp [wan_link0]   MAGICNUM 0xb51e5e1f
2022-02-02T13:15:37 Informational ppp [wan_link0]   AUTHPROTO PAP
2022-02-02T13:15:37 Informational ppp [wan_link0]   MRU 1492
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: SendConfigAck #2
2022-02-02T13:15:37 Informational ppp [wan_link0]   MAGICNUM 0xb51e5e1f
2022-02-02T13:15:37 Informational ppp [wan_link0]   AUTHPROTO PAP
2022-02-02T13:15:37 Informational ppp [wan_link0]   MRU 1492
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: rec'd Configure Request #2 (Ack-Rcvd)
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd
2022-02-02T13:15:37 Informational ppp [wan_link0]   MAGICNUM 0xe0085d10
2022-02-02T13:15:37 Informational ppp [wan_link0]   MRU 1492
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: rec'd Configure Ack #3 (Req-Sent)
2022-02-02T13:15:37 Informational ppp [wan_link0]   MAGICNUM 0xe0085d10
2022-02-02T13:15:37 Informational ppp [wan_link0]   MRU 1492
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: SendConfigReq #3
2022-02-02T13:15:37 Informational ppp [wan_link0] LCP: state change Ack-Rcvd --> Req-Sent
2022-02-02T13:15:35 Informational ppp [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd
2022-02-02T13:15:35 Informational ppp [wan_link0]   MAGICNUM 0xe0085d10
2022-02-02T13:15:35 Informational ppp [wan_link0]   MRU 1492
2022-02-02T13:15:35 Informational ppp [wan_link0] LCP: rec'd Configure Ack #2 (Req-Sent)
2022-02-02T13:15:35 Informational ppp [wan_link0]   MAGICNUM 0xe0085d10
2022-02-02T13:15:35 Informational ppp [wan_link0]   MRU 1492
2022-02-02T13:15:35 Informational ppp [wan_link0] LCP: SendConfigReq #2
2022-02-02T13:15:35 Informational ppp [wan_link0]   PROTOCOMP
2022-02-02T13:15:35 Informational ppp [wan_link0] LCP: rec'd Configure Reject #1 (Req-Sent)
2022-02-02T13:15:35 Informational ppp [wan_link0]   MAGICNUM 0xe0085d10
2022-02-02T13:15:35 Informational ppp [wan_link0]   MRU 1492
2022-02-02T13:15:35 Informational ppp [wan_link0]   PROTOCOMP
2022-02-02T13:15:35 Informational ppp [wan_link0] LCP: SendConfigReq #1
2022-02-02T13:15:35 Informational ppp [wan_link0] LCP: state change Starting --> Req-Sent
2022-02-02T13:15:35 Informational ppp [wan_link0] LCP: Up event
2022-02-02T13:15:35 Informational ppp [wan_link0] Link: UP event
2022-02-02T13:15:35 Informational ppp [wan_link0] PPPoE: connection successful
2022-02-02T13:15:34 Informational ppp PPPoE: rec'd ACNAME "************"
2022-02-02T13:15:34 Informational ppp [wan_link0] PPPoE: Connecting to '1und1'
2022-02-02T13:15:34 Informational ppp [wan_link0] LCP: LayerStart
2022-02-02T13:15:34 Informational ppp [wan_link0] LCP: state change Initial --> Starting
2022-02-02T13:15:34 Informational ppp [wan_link0] LCP: Open event
2022-02-02T13:15:34 Informational ppp [wan_link0] Link: OPEN event
2022-02-02T13:15:34 Informational ppp [wan] Bundle: Interface ng0 created
2022-02-02T13:15:34 Informational ppp web: web is not running
2022-02-02T13:15:34 Informational ppp process 14684 started, version 5.9
2022-02-02T13:15:34 Informational ppp
2022-02-02T13:15:34 Informational ppp Multi-link PPP daemon for FreeBSD
2022-02-02T13:15:34 Informational ppp process 53531 terminated
2022-02-02T13:15:34 Informational ppp [wan_link0] Link: Shutdown
2022-02-02T13:15:34 Informational ppp [wan] Bundle: Shutdown
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: Close event
2022-02-02T13:15:32 Informational ppp [wan_link0] Link: CLOSE event
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: state change Closing --> Initial
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: LayerFinish
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: Down event
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: state change Stopping --> Closing
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: Close event
2022-02-02T13:15:32 Informational ppp [wan_link0] Link: giving up after 0 reconnection attempts
2022-02-02T13:15:32 Informational ppp [wan_link0] Link: DOWN event
2022-02-02T13:15:32 Informational ppp [wan_link0] PPPoE: connection closed
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: LayerDown
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: SendTerminateAck #4
2022-02-02T13:15:32 Informational ppp [wan] IPV6CP: state change Closed --> Initial
2022-02-02T13:15:32 Informational ppp [wan] IPV6CP: Down event
2022-02-02T13:15:32 Informational ppp [wan] IPCP: state change Closed --> Initial
2022-02-02T13:15:32 Informational ppp [wan] IPCP: Down event
2022-02-02T13:15:32 Informational ppp [wan] IPV6CP: Close event
2022-02-02T13:15:32 Informational ppp [wan] IPCP: Close event
2022-02-02T13:15:32 Informational ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
2022-02-02T13:15:32 Informational ppp [wan_link0] Link: Leave bundle "wan"
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: state change Opened --> Stopping
2022-02-02T13:15:32 Informational ppp [wan_link0] LCP: rec'd Terminate Request #3 (Opened)
2022-02-02T13:15:32 Informational ppp [wan] Bundle: closing link "wan_link0"...
2022-02-02T13:15:32 Informational ppp [wan] Bundle: No NCPs left. Closing links...
2022-02-02T13:15:32 Informational ppp [wan] IPV6CP: LayerFinish
2022-02-02T13:15:32 Informational ppp [wan] IPV6CP: state change Closing --> Closed
2022-02-02T13:15:32 Informational ppp [wan] IPV6CP: rec'd Terminate Ack #2 (Closing)
2022-02-02T13:15:32 Informational ppp [wan] IPCP: LayerFinish
2022-02-02T13:15:32 Informational ppp [wan] IPCP: state change Closing --> Closed
2022-02-02T13:15:32 Informational ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing)
2022-02-02T13:15:32 Informational ppp [wan] IPCP: SendTerminateReq #5
2022-02-02T13:15:32 Informational ppp [wan] IPV6CP: SendTerminateReq #3
2022-02-02T13:15:32 Informational ppp [wan] IFACE: Rename interface pppoe1 to pppoe1
2022-02-02T13:15:32 Informational ppp [wan] IFACE: Down event
2022-02-02T13:15:01 Informational ppp [wan] IPV6CP: LayerDown
2022-02-02T13:15:01 Informational ppp [wan] IPV6CP: SendTerminateReq #2
2022-02-02T13:15:01 Informational ppp [wan] IPV6CP: state change Opened --> Closing
2022-02-02T13:15:01 Informational ppp [wan] IPV6CP: Close event
2022-02-02T13:15:01 Informational ppp [wan] IFACE: Removing IPv4 address from pppoe1 failed: Can't assign requested address
2022-02-02T13:15:01 Informational ppp [wan] IFACE: Delete route 0.0.0.0/0 <IP> failed: No such process
2022-02-02T13:15:00 Informational ppp [wan] IPCP: LayerDown
2022-02-02T13:15:00 Informational ppp [wan] IPCP: SendTerminateReq #4
2022-02-02T13:15:00 Informational ppp [wan] IPCP: state change Opened --> Closing
2022-02-02T13:15:00 Informational ppp [wan] IPCP: Close event
2022-02-02T13:15:00 Informational ppp [wan] IFACE: Close event
2022-02-02T13:15:00 Informational ppp caught fatal signal TERM
#21
So just did pull the reconnect forward. This is the part of the reconnect:

2022-02-02T10:40:33 Informational ppp process 30190 terminated
2022-02-02T10:40:33 Informational ppp [wan_link0] Link: Shutdown
2022-02-02T10:40:33 Informational ppp [wan] Bundle: Shutdown
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: Close event
2022-02-02T10:40:31 Informational ppp [wan_link0] Link: CLOSE event
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: state change Closing --> Initial
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: LayerFinish
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: Down event
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: state change Stopping --> Closing
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: Close event
2022-02-02T10:40:31 Informational ppp [wan_link0] Link: giving up after 0 reconnection attempts
2022-02-02T10:40:31 Informational ppp [wan_link0] Link: DOWN event
2022-02-02T10:40:31 Informational ppp [wan_link0] PPPoE: connection closed
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: LayerDown
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: SendTerminateAck #4
2022-02-02T10:40:31 Informational ppp [wan] IPV6CP: state change Closed --> Initial
2022-02-02T10:40:31 Informational ppp [wan] IPV6CP: Down event
2022-02-02T10:40:31 Informational ppp [wan] IPCP: state change Closed --> Initial
2022-02-02T10:40:31 Informational ppp [wan] IPCP: Down event
2022-02-02T10:40:31 Informational ppp [wan] IPV6CP: Close event
2022-02-02T10:40:31 Informational ppp [wan] IPCP: Close event
2022-02-02T10:40:31 Informational ppp [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
2022-02-02T10:40:31 Informational ppp [wan_link0] Link: Leave bundle "wan"
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: state change Opened --> Stopping
2022-02-02T10:40:31 Informational ppp [wan_link0] LCP: rec'd Terminate Request #3 (Opened)
2022-02-02T10:40:31 Informational ppp [wan] Bundle: closing link "wan_link0"...
2022-02-02T10:40:31 Informational ppp [wan] Bundle: No NCPs left. Closing links...
2022-02-02T10:40:31 Informational ppp [wan] IPV6CP: LayerFinish
2022-02-02T10:40:31 Informational ppp [wan] IPV6CP: state change Closing --> Closed
2022-02-02T10:40:31 Informational ppp [wan] IPV6CP: rec'd Terminate Ack #2 (Closing)
2022-02-02T10:40:31 Informational ppp [wan] IPCP: LayerFinish
2022-02-02T10:40:31 Informational ppp [wan] IPCP: state change Closing --> Closed
2022-02-02T10:40:31 Informational ppp [wan] IPCP: rec'd Terminate Ack #4 (Closing)
2022-02-02T10:40:31 Informational ppp [wan] IPCP: SendTerminateReq #5
2022-02-02T10:40:31 Informational ppp [wan] IPV6CP: SendTerminateReq #3
2022-02-02T10:40:31 Informational ppp [wan] IFACE: Rename interface pppoe1 to pppoe1
2022-02-02T10:40:31 Informational ppp [wan] IFACE: Down event
2022-02-02T10:40:31 Informational ppp can't lock /var/run/pppoe_wan.pid after 30 attempts
2022-02-02T10:40:30 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:29 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:28 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:27 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:26 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:25 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:24 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:23 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:22 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:21 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:20 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:19 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:18 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:17 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:16 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:15 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:14 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:13 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:12 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:11 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:10 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:08 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:07 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:06 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:05 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:04 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:03 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:02 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:01 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:01 Informational ppp [wan] IPV6CP: LayerDown
2022-02-02T10:40:01 Informational ppp [wan] IPV6CP: SendTerminateReq #2
2022-02-02T10:40:01 Informational ppp [wan] IPV6CP: state change Opened --> Closing
2022-02-02T10:40:01 Informational ppp [wan] IPV6CP: Close event
2022-02-02T10:40:01 Informational ppp [wan] IFACE: Removing IPv4 address from pppoe1 failed: Can't assign requested address
2022-02-02T10:40:01 Informational ppp [wan] IFACE: Delete route 0.0.0.0/0 <IP> failed: No such process
2022-02-02T10:40:00 Informational ppp [wan] IPCP: LayerDown
2022-02-02T10:40:00 Informational ppp [wan] IPCP: SendTerminateReq #4
2022-02-02T10:40:00 Informational ppp [wan] IPCP: state change Opened --> Closing
2022-02-02T10:40:00 Informational ppp [wan] IPCP: Close event
2022-02-02T10:40:00 Informational ppp [wan] IFACE: Close event
2022-02-02T10:40:00 Informational ppp caught fatal signal TERM
2022-02-02T10:40:00 Informational ppp waiting for process 30190 to die...
2022-02-02T10:40:00 Informational ppp process 44606 started, version 5.9
2022-02-02T10:40:00 Informational ppp
2022-02-02T10:40:00 Informational ppp Multi-link PPP daemon for FreeBSD


It then jut idles and you are offline. Using "configctl interface reconfigure wan" then reconnects:

2022-02-02T10:41:35 Informational ppp [wan]   <IP> -> <IP>
2022-02-02T10:41:35 Informational ppp [wan] IPCP: LayerUp
2022-02-02T10:41:35 Informational ppp [wan] IPCP: state change Ack-Sent --> Opened
2022-02-02T10:41:35 Informational ppp [wan]   IPADDR <IP>
2022-02-02T10:41:35 Informational ppp [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
2022-02-02T10:41:35 Informational ppp [wan]   IPADDR <IP>
2022-02-02T10:41:35 Informational ppp [wan] IPCP: SendConfigReq #3
2022-02-02T10:41:35 Informational ppp [wan]     <IP> is OK
2022-02-02T10:41:35 Informational ppp [wan]   IPADDR <IP>
2022-02-02T10:41:35 Informational ppp [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
2022-02-02T10:41:35 Informational ppp [wan] IFACE: Rename interface ng0 to pppoe1
2022-02-02T10:41:35 Informational ppp [wan] IFACE: Up event
2022-02-02T10:41:35 Informational ppp [wan]   <IPv6> -> <IPv6>
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: LayerUp
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: state change Ack-Sent --> Opened
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: rec'd Configure Ack #1 (Ack-Sent)
2022-02-02T10:41:35 Informational ppp [wan]   IPADDR 0.0.0.0
2022-02-02T10:41:35 Informational ppp [wan] IPCP: SendConfigReq #2
2022-02-02T10:41:35 Informational ppp [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
2022-02-02T10:41:35 Informational ppp [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: state change Req-Sent --> Ack-Sent
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: SendConfigAck #1
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: rec'd Configure Request #1 (Req-Sent)
2022-02-02T10:41:35 Informational ppp [wan] IPCP: state change Req-Sent --> Ack-Sent
2022-02-02T10:41:35 Informational ppp [wan]   IPADDR <IP>
2022-02-02T10:41:35 Informational ppp [wan] IPCP: SendConfigAck #1
2022-02-02T10:41:35 Informational ppp [wan]     <IP> is OK
2022-02-02T10:41:35 Informational ppp [wan]   IPADDR <IP>
2022-02-02T10:41:35 Informational ppp [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: SendConfigReq #1
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: state change Starting --> Req-Sent
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: Up event
2022-02-02T10:41:35 Informational ppp [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
2022-02-02T10:41:35 Informational ppp [wan]   IPADDR 0.0.0.0
2022-02-02T10:41:35 Informational ppp [wan] IPCP: SendConfigReq #1
2022-02-02T10:41:35 Informational ppp [wan] IPCP: state change Starting --> Req-Sent
2022-02-02T10:41:35 Informational ppp [wan] IPCP: Up event
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: LayerStart
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: state change Initial --> Starting
2022-02-02T10:41:35 Informational ppp [wan] IPV6CP: Open event
2022-02-02T10:41:35 Informational ppp [wan] IPCP: LayerStart
2022-02-02T10:41:35 Informational ppp [wan] IPCP: state change Initial --> Starting
2022-02-02T10:41:35 Informational ppp [wan] IPCP: Open event
2022-02-02T10:41:35 Informational ppp [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
2022-02-02T10:41:35 Informational ppp [wan_link0] Link: Join bundle "wan"
2022-02-02T10:41:35 Informational ppp [wan_link0] Link: Matched action 'bundle "wan" ""'
2022-02-02T10:41:35 Informational ppp [wan_link0] LCP: authorization successful
2022-02-02T10:41:35 Informational ppp [wan_link0]   MESG: [UI-SBR:55040,11136;UI-LINEID:1UND1.DEU.DTAG.CX6JK;]
2022-02-02T10:41:35 Informational ppp [wan_link0] PAP: rec'd ACK #1 len: 57
2022-02-02T10:41:35 Informational ppp [wan_link0] LCP: LayerUp
2022-02-02T10:41:35 Informational ppp [wan_link0] PAP: sending REQUEST #1 len: 52
2022-02-02T10:41:35 Informational ppp [wan_link0] PAP: using authname "****************"
2022-02-02T10:41:35 Informational ppp [wan_link0] LCP: auth: peer wants PAP, I want nothing
2022-02-02T10:41:35 Informational ppp [wan_link0] LCP: state change Ack-Rcvd --> Opened
2022-02-02T10:41:35 Informational ppp [wan_link0]   MAGICNUM 0xdf05b818
2022-02-02T10:41:35 Informational ppp [wan_link0]   AUTHPROTO PAP
2022-02-02T10:41:35 Informational ppp [wan_link0]   MRU 1492
2022-02-02T10:41:35 Informational ppp [wan_link0] LCP: SendConfigAck #2
2022-02-02T10:41:35 Informational ppp [wan_link0]   MAGICNUM 0xdf05b818
2022-02-02T10:41:35 Informational ppp [wan_link0]   AUTHPROTO PAP
2022-02-02T10:41:35 Informational ppp [wan_link0]   MRU 1492
2022-02-02T10:41:35 Informational ppp [wan_link0] LCP: rec'd Configure Request #2 (Ack-Rcvd)
2022-02-02T10:41:34 Informational ppp [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd
2022-02-02T10:41:34 Informational ppp [wan_link0]   MAGICNUM 0x5774ed80
2022-02-02T10:41:34 Informational ppp [wan_link0]   MRU 1492
2022-02-02T10:41:34 Informational ppp [wan_link0] LCP: rec'd Configure Ack #3 (Req-Sent)
2022-02-02T10:41:34 Informational ppp [wan_link0]   MAGICNUM 0x5774ed80
2022-02-02T10:41:34 Informational ppp [wan_link0]   MRU 1492
2022-02-02T10:41:34 Informational ppp [wan_link0] LCP: SendConfigReq #3
2022-02-02T10:41:34 Informational ppp [wan_link0] LCP: state change Ack-Rcvd --> Req-Sent
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd
2022-02-02T10:41:32 Informational ppp [wan_link0]   MAGICNUM 0x5774ed80
2022-02-02T10:41:32 Informational ppp [wan_link0]   MRU 1492
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: rec'd Configure Ack #2 (Req-Sent)
2022-02-02T10:41:32 Informational ppp [wan_link0]   MAGICNUM 0x5774ed80
2022-02-02T10:41:32 Informational ppp [wan_link0]   MRU 1492
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: SendConfigReq #2
2022-02-02T10:41:32 Informational ppp [wan_link0]   PROTOCOMP
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: rec'd Configure Reject #1 (Req-Sent)
2022-02-02T10:41:32 Informational ppp [wan_link0]   MAGICNUM 0x5774ed80
2022-02-02T10:41:32 Informational ppp [wan_link0]   MRU 1492
2022-02-02T10:41:32 Informational ppp [wan_link0]   PROTOCOMP
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: SendConfigReq #1
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: state change Starting --> Req-Sent
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: Up event
2022-02-02T10:41:32 Informational ppp [wan_link0] Link: UP event
2022-02-02T10:41:32 Informational ppp [wan_link0] PPPoE: connection successful
2022-02-02T10:41:32 Informational ppp PPPoE: rec'd ACNAME "************"
2022-02-02T10:41:32 Informational ppp [wan_link0] PPPoE: Connecting to '1und1'
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: LayerStart
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: state change Initial --> Starting
2022-02-02T10:41:32 Informational ppp [wan_link0] LCP: Open event
2022-02-02T10:41:32 Informational ppp [wan_link0] Link: OPEN event
2022-02-02T10:41:32 Informational ppp [wan] Bundle: Interface ng0 created
2022-02-02T10:41:32 Informational ppp web: web is not running
2022-02-02T10:41:32 Informational ppp process 16047 started, version 5.9
2022-02-02T10:41:32 Informational ppp
2022-02-02T10:41:32 Informational ppp Multi-link PPP daemon for FreeBSD


Hope I redacted personal information enough...
#22
mpd5 läuft auch.

Würde ein ppp log helfen, wenn ich den cron für die Trennung mal eben nach vorne ziehe?
#23
Hi there,

had this in the morning as well, after upgrading yesterday. Sadly did a restart, so logs are gone.

Checking for unbound and mdp5 now:
unbound is running, mdp5 not

Cheers
#24
Not that I know of. I have an unbound running for my local network, that is doing DoT now.

It seems to work with IPv6 even though I found the following:
- To properly announce the local lan DNS to clients via RA, I need to use the fe80:: IPv6 of my LAN interface. As radvd in opnsense is not able to handle Prefix changes. The fe80:: has to be specified in the radvd manual settings while RA is on "nicht verwaltet"

- Apparently the firewall only uses the primary IPv6 of my LAN interface. Having a target for DNS as "LAN Netzwerk" or "LAN Adresse" will not include fe80::. I needed to add a specific rule to allow DNS coming in.

- Unbound is not updating properly when the IPv6 changes and also not when opnsense is booting up. It seems to be connected to another issue: https://forum.opnsense.org/index.php?topic=20030.0
When the WAN interface has no global IPv6, the LAN won't have one either (although it already could have fe80:: ) and unbound will not bind to fe80::. Hence I need to relaunch the LAN interface and the restart unbound after global IPv6 on WAN is available.

When I have corrected all of the above, my clients can use DNS via IPv4 and IPv6 through the DoT unbound.

But overall Opnsense and IPv6 still don't want to be friends. ;-D
#25
Hi there,

while trying to get IPv6 working (again), I figured, that after reboot, my WAN and LAN interface does not get an IPv6. I need to reload the WAN interface to trigger IPv6 for the WAN and LAN interface.

Working on 20.7.4 with following WAN configuration:
- IPv4: PPPoE
- IPv6: DHCPv6
DHCPv6 client configuration:
- Request only an IPv6 prefix: not set
- Präfixdelegationsgröße: 64
- Sende einen IPv6-Präfixhinweis: set
- IPv4-Verbindung verwenden: set
- Verwende VLAN-Priorität: Deaktiviert

Any idea what this could be? Let me know if I can provide specific logging.
#26
I have the issue as well. It seems, that unbound cannot contact the DNS server via IPv6. If you increase unbound logging you will also see:


2020-11-12T11:29:03 unbound[94702] [94702:1] info: error sending query to auth server 2a02:2970:1002::18 port 853
2020-11-12T11:29:03 unbound[94702] [94702:1] error: outgoing tcp: bind: Can't assign requested address
2020-11-12T11:29:03 unbound[94702] [94702:1] debug: sending to target: <.> 2a02:2970:1002::18#853


I could make the error disappear, when turning off requesting a ipv6 prefix on my WAN. Then the WAN gets an IP and unbound is able to contact the servers. However then IPv6 in my network is not working anymore. I would guess, that unbound somewhat is not correctly attaching to the right IPv6s on the interfaces, when using prefix delegation. (In my case it is configured to attach to all interfaces.)

Seeing my interfaces, it also shows my LAN IPv4 + public IPv6 on my LAN interface and public IPv4 + LAN IPv6 on my WAN interface.
I would have thought to have all public IPs on my WAN and all LAN IPs on my LAN... Somehow it is mixed up?
#27
Ok, so I finally was able to upgrade. I did a few restarts, however that didn't help. Then powering off the router completely and booting somewhat worked. I have no clue why.

It then was able to connect and update. Interesting enough, the health check went through within 30seconds (only finding some missing files for acme.sh). When doing the health check for the post above, it took above 30min.
#28
That is what I did above...
#29
Not sure what to do next? Don't want to break anything. Anyone knows how to solve this properly?
#30
I have similar issues. I already experienced this on the 20.7 upgrade, but then switching the mirror from (default) to something else worked.
Now I get the following status on mirrors
(default): Timeout while connecting to the selected mirror.
deciso.nl: Timeout while connecting to the selected mirror.
LeaseWeb, Frankfurt: Die Firmwarestatusprüfung wurde intern abgebrochen. Bitte versuchen Sie es erneut.

Current version in dashboard: 20.7.1

Checking the health check, something seems to be off:
***GOT REQUEST TO AUDIT HEALTH***
>>> Check installed kernel version
Version 20.7 is incorrect, expected: 20.7.1
>>> Check for missing or altered kernel files
No problems detected.
>>> Check installed base version
Version 20.7 is incorrect, expected: 20.7.1
>>> Check for missing or altered base files
No problems detected.
>>> Check for and install missing package dependencies
Checking all packages: .......... done
>>> Check for missing or altered package files
Checking all packages: .......... done
>>> Check for core packages consistency
Checking core packages: ........................


core packages checkt es nun schon einige Zeit.

Log file shows just the following:
2020-08-17T07:21:16 pkg-static[75242] opnsense upgraded: 20.7 -> 20.7.1

Using Production, LibreSSL. Disk space is plenty 5% used.