Vodafone-Station IPv4 Probleme mit dnsmasq

gnude · ‎26.11.2022

Hallo,

auch wenn es sich jetzt um eine Frage aus dem Ubuntu Umfeld handelt die ich hier stelle hoffe ich doch das mir jemand helfen kann und vielleicht gute Tipps hat wie ich das Problem angehen kann. Ich bin total ratlos und weiss nicht mehr wo ich suchen soll.

Kurz eine Beschreibung der Ist-Situation:

Ich bin bei Vodafone Kabelkunde und habe eine Vodafone Station die mit Docsis angebunden ist.
Der Vertrag ist nen 1000er Cablemax Vertrag.

Die Vodafone Station hat eine Reihe von Portweiterleitungen auf den internen Server eingerichtet. Die DHCP Funktion habe ich deaktiviert.
Zusätzlich ist auf der Vodafone Station noch der Dyndns Dienst noip.biz eingerichtet um das Setup von Aussen erreichbar zu machen.
Ich habe ein Notebook mit Ubuntu 22.04 eingerichtet. Das Notebook hat eine feste IP Adresse. Auf dem Notebook habe ich Virtual-Box installiert und als VM ein Ubuntu 22.04 Server.
Der Server bietet folgende Dienste: Mailserver (Postfix, Dovecot, Fetchmail), Webserver, DLNA Server, eJabberd Server.
Zusätlich ist noch ein dnsmasq eingerichtet der als DNS und DHCP Server dient. Zuzätzlich habe ich auf dem Server ddclient eingerichet
und noch einen zweiten dyndsndienst. Das funktioniert aber alles.
Die Einstellungen von dsnmasq sind:

server=192.168.178.1
dhcp-option=3,192.168.178.1
dhcp-option=6,192.168.178.39
dhcp-range=192.168.178.50,192.168.178.200,12h
address=/gnude.feste-ip.net/192.168.178.39

und ein ip a auf dem Server ergibt folgendes.

root@server2204:~# ip a
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000
link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
inet 127.0.0.1/8 scope host lo
valid_lft forever preferred_lft forever
inet6 ::1/128 scope host
valid_lft forever preferred_lft forever
2: enp0s3: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc fq_codel state UP group default qlen 1000
link/ether 08:00:27:02:58:17 brd ff:ff:ff:ff:ff:ff
inet 192.168.178.39/24 brd 192.168.178.255 scope global enp0s3
valid_lft forever preferred_lft forever
inet 192.168.178.40/24 brd 192.168.178.255 scope global secondary enp0s3
valid_lft forever preferred_lft forever
inet6 2a02:908:1d16:10e0:9d6:6eb5:fdfd:d8b9/128 scope global dynamic noprefixroute
valid_lft 356071sec preferred_lft 356071sec
inet6 2a02:908:1d16:10e0:a00:27ff:fe02:5817/64 scope global dynamic mngtmpaddr noprefixroute
valid_lft 79268sec preferred_lft 36068sec
inet6 fe80::a00:27ff:fe02:5817/64 scope link
valid_lft forever preferred_lft forever
root@server2204:~#

Auf dem Smartphone habe ich DHCP aktiviert und dort ist im eMail Client der Mailserver über den Dyndns Dienst eingerichet,
so das ich wenn ich unterwegs bin von aussen meinen Server erreichen kann um die eMails dort abzurufen.
Im ersten Schritt hatte ich die Vodafone Box noch DHCP machen lassen, doch dann gab es Probleme mit dem NAT-Pinning wenn ich mich im lokalen Netz befunden habe und von dort über die DynDNS Adresse meine eMails abrufen wollte.
Daher der Schritt zu deinem eigenen DNS und DHCP Server.

Nun treten folgende Probleme auf:
Nach einiger Zeit kann ich keine IPv4 Adresse mehr beziehen über den DHCP Server. Dann bekommt das Smartphone nur noch eine IPv6 Adresse. Wenn ich dann im lokalen Netz bin und dort auf dem Notebook "web.threema.ch" aufrufe findet die Seite das Smartphone nicht mehr.
Ich muss beim Smartphone dann Wifi abschalten und über die mobilen Daten gehen.
Die Lösung ist: Vodafone Box kurz Stromlos machen. Anschliessend kann das Smartphone wieder über den DHCP eine IP Adresse beziehen und alles klappt.
Aber das hält nicht lange an und nach einiger Zeit.... klappt es nicht mehr. Zu diesem Zeitpunkt funktioniert nur IPv6, ich kann IPv6 Adressen anpingen aber Webseiten die nur per IPv4 erreichbar sind (www.web.de) gehen nicht mehr. Die IPv6 Adressen schon.
Die Zeitabstände zwischen den "Ausfällen" werden immer kürzer und ich muss in immer kürzeren Abständen die Vodafone-Station Stromlos machen.
Irgendwann brachte auch das nichts mehr und ich hab die Vodafone-Station komplett resettet und neu eingerichtet. Danach hatte ich einige Wochen Ruhe. Dann ging es wieder los mit den Problmen und nach jedem Stromlos machen wird der Zeitraum kürzer.

Auf dem Server habe ich mal einen Log Auszug von einem Zeitraum in dem IPv4 ausgefallen ist und nur noch IPv6 zur Verfügung steht.

Nov 22 02:45:35 thinkpad rtkit-daemon[1081]: message repeated 2 times: [ Supervising 9 threads of 6 processes of 1 users.]
Nov 22 02:59:15 thinkpad wpa_supplicant[900]: wlp3s0: WPA: Group rekeying completed with 08:a7:c0:ec:64:c0 [GTK=CCMP]
Nov 22 02:59:18 thinkpad kernel: [10025.248703] wlp3s0: deauthenticated from 08:a7:c0:ec:64:c0 (Reason: 2=PREV_AUTH_NOT_VALID)
Nov 22 02:59:17 thinkpad wpa_supplicant[900]: message repeated 3 times: [ wlp3s0: WPA: Group rekeying completed with 08:a7:c0:ec:64:c0 [GTK=CCMP]]
Nov 22 02:59:19 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-DISCONNECTED bssid=08:a7:c0:ec:64:c0 reason=2
Nov 22 02:59:19 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Nov 22 02:59:19 thinkpad NetworkManager[862]: <info> [1669082359.2406] device (wlp3s0): supplicant interface state: completed -> disconnected
Nov 22 02:59:19 thinkpad NetworkManager[862]: <info> [1669082359.3109] device (wlp3s0): supplicant interface state: disconnected -> scanning
Nov 22 02:59:19 thinkpad gnome-shell[2441]: An active wireless connection, in infrastructure mode, involves no access point?
Nov 22 02:59:22 thinkpad wpa_supplicant[900]: wlp3s0: SME: Trying to authenticate with 08:a7:c0:ec:64:c0 (SSID='Charlotte' freq=2437 MHz)
Nov 22 02:59:22 thinkpad kernel: [10028.526254] wlp3s0: authenticate with 08:a7:c0:ec:64:c0
Nov 22 02:59:22 thinkpad kernel: [10028.529170] wlp3s0: send auth to 08:a7:c0:ec:64:c0 (try 1/3)
Nov 22 02:59:22 thinkpad kernel: [10028.531625] wlp3s0: authenticated
Nov 22 02:59:22 thinkpad kernel: [10028.536713] wlp3s0: associate with 08:a7:c0:ec:64:c0 (try 1/3)
Nov 22 02:59:22 thinkpad kernel: [10028.540960] wlp3s0: RX AssocResp from 08:a7:c0:ec:64:c0 (capab=0x1411 status=0 aid=21)
Nov 22 02:59:22 thinkpad kernel: [10028.546880] wlp3s0: associated
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.2697] device (wlp3s0): supplicant interface state: scanning -> authenticating
Nov 22 02:59:22 thinkpad wpa_supplicant[900]: wlp3s0: Trying to associate with 08:a7:c0:ec:64:c0 (SSID='Charlotte' freq=2437 MHz)
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.2725] device (wlp3s0): supplicant interface state: authenticating -> associating
Nov 22 02:59:22 thinkpad wpa_supplicant[900]: wlp3s0: Associated with 08:a7:c0:ec:64:c0
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.2928] device (wlp3s0): supplicant interface state: associating -> associated
Nov 22 02:59:22 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.2929] device (wlp3s0): ip:dhcp4: restarting
Nov 22 02:59:22 thinkpad wpa_supplicant[900]: wlp3s0: WPA: Key negotiation completed with 08:a7:c0:ec:64:c0 [PTK=CCMP GTK=CCMP]
Nov 22 02:59:22 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-CONNECTED - Connection to 08:a7:c0:ec:64:c0 completed [id=0 id_str=]
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.5940] dhcp4 (wlp3s0): canceled DHCP transaction
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.5941] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Nov 22 02:59:22 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-45 noise=9999 txrate=1000
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.6239] dhcp4 (wlp3s0): state changed no lease
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.6699] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.7565] device (wlp3s0): ip:dhcp6: restarting
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.7976] dhcp6 (wlp3s0): canceled DHCP transaction
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.8204] dhcp6 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.8206] dhcp6 (wlp3s0): state changed no lease
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.8208] dhcp6 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.9311] device (wlp3s0): supplicant interface state: associated -> 4way_handshake
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.9311] device (wlp3s0): supplicant interface state: 4way_handshake -> completed
Nov 22 02:59:22 thinkpad NetworkManager[862]: <info> [1669082362.9367] dhcp6 (wlp3s0): state changed new lease, address=2a02:908:1d16:10e0:703e:d423:83af:73fb
Nov 22 02:59:23 thinkpad dbus-daemon[861]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.14' (uid=0 pid=
862 comm="/usr/sbin/NetworkManager --no-daemon " label="unconfined")
Nov 22 02:59:23 thinkpad systemd[1]: Starting Network Manager Script Dispatcher Service...
Nov 22 02:59:23 thinkpad dbus-daemon[861]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Nov 22 02:59:23 thinkpad systemd[1]: Started Network Manager Script Dispatcher Service.
Nov 22 02:59:32 thinkpad systemd-resolved[839]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 192.168.178.39.
Nov 22 02:59:33 thinkpad systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Nov 22 02:59:40 thinkpad systemd-resolved[839]: Using degraded feature set TCP instead of UDP for DNS server 192.168.178.39.
Nov 22 03:00:07 thinkpad avahi-daemon[858]: Withdrawing address record for 192.168.178.169 on wlp3s0.
Nov 22 03:00:08 thinkpad avahi-daemon[858]: Leaving mDNS multicast group on interface wlp3s0.IPv4 with address 192.168.178.169.
Nov 22 03:00:08 thinkpad systemd-resolved[839]: wlp3s0: Bus client set DNS server list to: 2a02:908:1d16:10e0:10:18ff:feec:64bc
Nov 22 03:00:26 thinkpad rtkit-daemon[1081]: Supervising 9 threads of 6 processes of 1 users.
Nov 22 03:01:43 thinkpad rtkit-daemon[1081]: message repeated 3 times: [ Supervising 9 threads of 6 processes of 1 users.]
Nov 22 03:10:02 thinkpad CRON[19903]: (root) CMD (test -e /run/systemd/system || SERVICE_MODE=1 /sbin/e2scrub_all -A -r)
Nov 22 03:17:01 thinkpad CRON[20047]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Nov 22 03:42:53 thinkpad smartd[894]: Device: /dev/sda [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 112 to 113
Nov 22 03:59:15 thinkpad wpa_supplicant[900]: wlp3s0: WPA: Group rekeying completed with 08:a7:c0:ec:64:c0 [GTK=CCMP]
Nov 22 04:17:01 thinkpad CRON[21137]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Nov 22 04:17:44 thinkpad rtkit-daemon[1081]: Supervising 9 threads of 6 processes of 1 users.
Nov 22 04:17:44 thinkpad rtkit-daemon[1081]: Supervising 9 threads of 6 processes of 1 users.
Nov 22 04:59:15 thinkpad wpa_supplicant[900]: wlp3s0: WPA: Group rekeying completed with 08:a7:c0:ec:64:c0 [GTK=CCMP]
Nov 22 05:12:52 thinkpad smartd[894]: Device: /dev/sda [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 113 to 112
Nov 22 05:17:01 thinkpad CRON[22189]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Nov 22 05:21:49 thinkpad systemd[1]: Starting Daily apt download activities...
Nov 22 05:23:20 thinkpad systemd[1]: apt-daily.service: Deactivated successfully.
Nov 22 05:23:20 thinkpad systemd[1]: Finished Daily apt download activities.
Nov 22 05:23:20 thinkpad systemd[1]: apt-daily.service: Consumed 1min 26.620s CPU time.
Nov 22 05:59:15 thinkpad wpa_supplicant[900]: wlp3s0: WPA: Group rekeying completed with 08:a7:c0:ec:64:c0 [GTK=CCMP]
Nov 22 05:59:19 thinkpad kernel: [20825.199038] wlp3s0: deauthenticated from 08:a7:c0:ec:64:c0 (Reason: 2=PREV_AUTH_NOT_VALID)
Nov 22 05:59:18 thinkpad wpa_supplicant[900]: message repeated 3 times: [ wlp3s0: WPA: Group rekeying completed with 08:a7:c0:ec:64:c0 [GTK=CCMP]]
Nov 22 05:59:19 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-DISCONNECTED bssid=08:a7:c0:ec:64:c0 reason=2
Nov 22 05:59:19 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Nov 22 05:59:19 thinkpad NetworkManager[862]: <info> [1669093159.2274] device (wlp3s0): supplicant interface state: completed -> disconnected
Nov 22 05:59:19 thinkpad gnome-shell[2441]: An active wireless connection, in infrastructure mode, involves no access point?
Nov 22 05:59:19 thinkpad NetworkManager[862]: <info> [1669093159.2633] device (wlp3s0): supplicant interface state: disconnected -> scanning
Nov 22 05:59:22 thinkpad wpa_supplicant[900]: wlp3s0: SME: Trying to authenticate with 08:a7:c0:ec:64:c0 (SSID='Charlotte' freq=2437 MHz)
Nov 22 05:59:22 thinkpad kernel: [20828.461714] wlp3s0: authenticate with 08:a7:c0:ec:64:c0
Nov 22 05:59:22 thinkpad kernel: [20828.464275] wlp3s0: send auth to 08:a7:c0:ec:64:c0 (try 1/3)
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.2922] device (wlp3s0): supplicant interface state: scanning -> authenticating
Nov 22 05:59:22 thinkpad kernel: [20828.479046] wlp3s0: authenticated
Nov 22 05:59:22 thinkpad kernel: [20828.482118] wlp3s0: associate with 08:a7:c0:ec:64:c0 (try 1/3)
Nov 22 05:59:22 thinkpad kernel: [20828.499530] wlp3s0: RX AssocResp from 08:a7:c0:ec:64:c0 (capab=0x1411 status=0 aid=24)
Nov 22 05:59:22 thinkpad kernel: [20828.513342] wlp3s0: associated
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3065] device (wlp3s0): supplicant interface state: authenticating -> associating
Nov 22 05:59:22 thinkpad wpa_supplicant[900]: wlp3s0: Trying to associate with 08:a7:c0:ec:64:c0 (SSID='Charlotte' freq=2437 MHz)
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3463] device (wlp3s0): supplicant interface state: associating -> associated
Nov 22 05:59:22 thinkpad wpa_supplicant[900]: wlp3s0: Associated with 08:a7:c0:ec:64:c0
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3464] device (wlp3s0): ip:dhcp4: restarting
Nov 22 05:59:22 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3684] dhcp4 (wlp3s0): canceled DHCP transaction
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3685] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3687] device (wlp3s0): ip:dhcp6: restarting
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3687] dhcp6 (wlp3s0): canceled DHCP transaction
Nov 22 05:59:22 thinkpad wpa_supplicant[900]: wlp3s0: WPA: Key negotiation completed with 08:a7:c0:ec:64:c0 [PTK=CCMP GTK=CCMP]
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3687] dhcp6 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Nov 22 05:59:22 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-CONNECTED - Connection to 08:a7:c0:ec:64:c0 completed [id=0 id_str=]
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3687] dhcp6 (wlp3s0): state changed no lease
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3688] dhcp6 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.3691] device (wlp3s0): supplicant interface state: associated -> 4way_handshake
Nov 22 05:59:22 thinkpad NetworkManager[862]: <info> [1669093162.4182] device (wlp3s0): supplicant interface state: 4way_handshake -> completed
Nov 22 05:59:22 thinkpad wpa_supplicant[900]: wlp3s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-45 noise=9999 txrate=1000
Nov 22 05:59:23 thinkpad NetworkManager[862]: <info> [1669093163.5406] dhcp6 (wlp3s0): state changed new lease, address=2a02:908:1d16:10e0:703e:d423:83af:73fb

Im Moment bin ich völlig ratlos wo der Fehler liegen könnte. Und auch das nach einem Neustart der Vodafone-Station das wieder klappt aber die Zeitabstände immer kürzer werden.
Vielleicht liegt es an einem zu vollen Arp-Cache auf der Vodafone-Box?

Ich freue mich auf Ideen und Vorschäge wo ich mit der Fehlersuche beginnen kann.