24.1.9_3 - Network Time Daemon startet nicht mehr

[726511918]

Guten Abend zusammen,
ich habe heute Nachmittag ein Update von 24.1.7_4 auf 24.1.8 durchgeführt. Nach dem planmäßigen Neustart der Box, startet der Network Time Daemon nicht mehr. Ich habe die Box im Nachgang 2-3 Mal neu gestartet, weil ich dachte, dass evtl. noch ein alte PID rumgeistert. Damit die UI durcheinander kommt. Leider Fehlanzeige.

Im Logfile des NTP sind folgende Einträge zu sehen:

Code Select Expand


2024-05-30T21:48:46 Error ntpd daemon child died with signal 11
2024-05-30T21:48:46 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:48:46 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:44:21 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:44:21 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:43:39 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:43:39 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:43:32 Error ntpd daemon child died with signal 11
2024-05-30T21:43:32 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:43:32 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:43:25 Error ntpd daemon child died with signal 11
2024-05-30T21:43:25 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:43:24 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:43:03 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:43:03 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:42:58 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:42:58 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:42:42 Error ntpd daemon child died with signal 11
2024-05-30T21:42:42 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:42:42 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:42:20 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:42:20 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use
2024-05-30T21:39:15 Error ntpd daemon child died with signal 11
2024-05-30T21:39:15 Error ntpd unable to create socket on wg2 (20) for 192.168.52.1:123
2024-05-30T21:39:15 Error ntpd bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use


Daher via SSH auf die Box eingeloggt und geschaut, was bereits auf dem Port 123 läuft.

Code Select Expand


root@fw01:~ # sockstat -l46 | grep ":123"
root@fw01:~ #

Wie man sieht, läuft aktuell kein anderer Service. Um so verwunderlicher die Fehlermeldungen im Logfile.

Auch gibt es zu NTPd keine (aktuelle) PID Datei.

Code Select Expand


root@fw01:~ # cat /var/run/ntpd.pid
cat: /var/run/ntpd.pid: No such file or directory


Kann jemand das Problem bei seiner Box nachvollziehen?


Grüße

[Dragor17]

Hi, ja bei mir startet der NTP auch nicht auch Port 123 auf WG1 IP
Mehrfacher Neustart wie bei dir keine Änderung.

[726511918]

Kann sich das jemand von den Devs mal aschauen?!

[726511918]

Problem besteht bei mir weiterhin nach dem Update auf 24.1.9_3.

[franco]

> 2024-05-30T21:48:46   Error   ntpd    unable to create socket on wg2 (20) for 192.168.52.1:123
> 2024-05-30T21:48:46   Error   ntpd    bind(40) AF_INET 192.168.52.1:123 flags 0x11 failed: Address already in use

Vielleicht funktioniert es auf einem WireGuard Interface einfach nicht?


Grüsse
Franco

[Patrick M. Hausen]

Habt ihr beim ntpd die listen interfaces einzeln aktiviert oder einfach das "All (recommended)" drin gelassen?

[726511918]

Vielleicht funktioniert es auf einem WireGuard Interface einfach nicht?

Das bedeutet, dass es bis 24.1.8 ein Bug war oder wie ist deine Antwort zu verstehen?

Habt ihr beim ntpd die listen interfaces einzeln aktiviert oder einfach das "All (recommended)" drin gelassen?

Default - All Interfaces. Das hat auch bis zum Update auf 24.1.8 so funktioniert.

[franco]

> Das bedeutet, dass es bis 24.1.8 ein Bug war oder wie ist deine Antwort zu verstehen?

Eine Vermutung aus Mangel an weiteren Informationen und weiteren Reports zum gleichen Fehlerbild.

Im Zweifelsfall die eigene Hypothese testen:

# opnsense-revert -r 24.1.8 opnsense


Grüsse
Franco

[726511918]

# opnsense-revert -r 24.1.8 opnsense

Du meinst sicherlich opnsense-revert -r 24.1.7_4 opnsense, oder? Weil in dieser Version lief der NTPd problemlos.

[franco]

Ja du hast Recht. "24.1.7" dann und nicht die "_4" angeben.

Darunter klappt es aber nicht mehr wegen dem Python 3.11 Switch.


Grüsse
Franco

[726511918]

Ja du hast Recht. "24.1.7" dann und nicht die "_4" angeben.

Danke für die Korrektur.

Bevor ich los lege noch die Frage, was du an Informationen nach dem Downgrade von meinem System benötigst. Reicht der Auszug des Logfiles von NTPd über die UI?

[franco]

Die Aussage ob NTP dann wieder läuft oder eben auch nicht reicht vorerst aus.


Grüsse
Franco

[726511918]

Der NTPd läuft mit 24.1.7_4 auch nicht mehr.  :-\ Sobald ich ausschließlich meine LAN Interface in der UI selektiere, startet der NTPd problemlos.

Ich bin mir zu 99,99% sicher, dass er damals noch lief. Kann es evtl. noch aus einer Kombination von aktueller Konfiguration + 24.1.7_4 sein?

[franco]

Ja, konfigurationsbedingt kann das schon sein. Ob da ein Versionsupdate mitspielt oder nicht scheint eher unklar dann.


Grüsse
Franco