am 24.03.2022 06:42
Hallo,
ich habe eine FRITZ!Box 6591 Vodafone-Leihbox in der Firmwareversion 07.29.
Unregelmäßig (eher im Wochen-/Monatsabstand) stürzt die Fritzbox ab (Uhrzeit spielt auch keine Rolle) und startet neu. Das ist ärgerlich - gerade wenn es tagsüber oder bei nächtlichen Backups auftritt.
Das Ereignislog ist nach dem Neustart weg. Aber in der erweiterterten Supportdatei ist folgendes zu finden:
[71309.608763] BUG: internet: ipmasq: FATAL: UDP <ipv4-lan-addr>/37787 (<wan-ipv4-addr>/37787) still in hashtab after unhash [71309.620344] ------------[ cut here ]------------ [71309.620416] WARNING: CPU: 0 PID: 0 at /GU/NETWORK_SOURCE_atomp7_build/kernelmodules/libs/datapipe/gen/sharedlibs/datapipe/datapipe.c:3708 0xc5056d78 dpmod_bugmsg+0x88/0xd0 [kdsldmod] [71309.620418] Modules linked in: krtp(PO) xhci_pci xhci_hcd userman_mod(PO) qca_ol(O) umac(O) ath_spectral(PO) ath_dfs(PO) qdf(O) asf(PO) mem_manager(PO) aae(PO) dect_io(P) avm_dect(P) capi_codec(P) isdn_fbox_fon5(P) pcmlink(P) avm_dvbc_drv(O) cable_netdev(O) toe_drv(O) swapi_mod(O) DWC_ETH_QOS_GBE(O) sec_kernel(O) DWC_ETH_QOS veth mux_drv(O) pumalbr0flt_drv(PO) avm_pa_hw(O) puma_lpal(O) cppp(O) wifi_proxy_netdev(O) dpd_netdev(O) puma7_pp_init hil_drv(O) kdsldmod(PO) cchardev(PO) avm_pp_counter(PO) cprocfsmod(PO) sgc_drv(O) pp_drv(O) pdsp_drv(O) Piglet_noemif(P) led_module(PO) [71309.620463] CPU: 0 PID: 0 Comm: swapper/0 Tainted: P O 4.9.250 #1 [71309.620464] Hardware name: Intel Corporation PUMA 7 C0 PLATFORM/TBD, BIOS CGM2.86C.627075.R.1910091149 10/09/2019 [71309.620466] b400bc50 813a6f95 00000000 c5056d78 b400bc68 810eb017 00000e7c b400bc98 [71309.620473] c513f634 a6135320 b400bc7c 81051b06 00000009 00000000 00000000 b400be9c [71309.620480] c5056d78 c5116d04 b400bc98 c5116cf6 aba1e440 c511948f 3a475542 746e6920 [71309.620486] Call Trace: [71309.620489] <IRQ> [71309.620496] dump_stack+0x51/0x6c [71309.620555] ? dpmod_bugmsg+0x88/0xd0 [kdsldmod] [71309.620559] __warn+0xb2/0xc9 [71309.620563] warn_slowpath_null+0x26/0x30 [71309.620622] dpmod_bugmsg+0x88/0xd0 [kdsldmod] [71309.620627] ? enqueue_task_fair+0x861/0xdb0 [71309.620630] ? sched_clock_cpu+0x115/0x170 [71309.620634] ? find_next_bit+0x1b/0x30 [71309.620636] ? cpumask_next_and+0x24/0x30 [71309.620638] ? update_sd_lb_stats+0x110/0x490 [71309.620641] ? number+0x3bc/0x3c0 [71309.620643] ? update_sd_lb_stats+0x420/0x490 [71309.620646] ? vsnprintf+0x32c/0x5a0 [71309.620648] ? snprintf+0x1d/0x20 [71309.620708] ? ipaddr2str+0x54/0x60 [kdsldmod] [71309.620769] masq_release+0x3e2/0x450 [kdsldmod] [71309.620772] ? _raw_spin_unlock_bh+0x13/0x20 [71309.620829] ? ctimer_unsetup_internal+0x15f/0x190 [kdsldmod] [71309.620890] masq_expire_timer+0x49/0x90 [kdsldmod] [71309.620947] ctimer_internal_docallouts+0x21e/0x340 [kdsldmod] [71309.620990] ? pcp_request_handler+0x140/0x140 [kdsldmod] [71309.621034] timer_function+0x1d/0xc0 [kdsldmod] [71309.621078] ? pcp_request_handler+0x140/0x140 [kdsldmod] [71309.621082] call_timer_fn.isra.29+0x29/0xc0 [71309.621084] ? rebalance_domains+0xe4/0x2a0 [71309.621087] run_timer_softirq+0x1b8/0x3b0 [71309.621130] ? pcp_request_handler+0x140/0x140 [kdsldmod] [71309.621133] ? run_rebalance_domains+0x118/0x1a0 [71309.621135] __do_softirq+0xf8/0x370 [71309.621137] ? takeover_tasklets+0x110/0x110 [71309.621141] do_softirq_own_stack+0x1d/0x30 [71309.621142] <EOI> [71309.621144] irq_exit+0xb5/0xc0 [71309.621147] smp_apic_timer_interrupt+0x4b/0x90 [71309.621150] apic_timer_interrupt+0x2d/0x34 [71309.621154] ? ip_tunnel_rcv.cold.38+0x34/0x40 [71309.621157] ? cpuidle_enter_state+0x14d/0x250 [71309.621159] cpuidle_enter+0xf/0x20 [71309.621162] call_cpuidle+0x1c/0x30 [71309.621164] cpu_startup_entry+0x10f/0x1a0 [71309.621167] rest_init+0x6c/0x6f [71309.621170] start_kernel+0x366/0x370 [71309.621172] i386_start_kernel+0x43/0x45 [71309.621174] ---[ end trace 34a02f163d3cd56b ]--- [71309.621177] Kernel panic - not syncing: BUG: internet: ipmasq: FATAL: UDP <ipv4-lan-addr>/37787 (<wan-ipv4-addr>/37787) still in hashtab after unhash [71309.621177] [71309.637114] CPU: 0 PID: 0 Comm: swapper/0 Tainted: P W O 4.9.250 #1 [71309.645182] Hardware name: Intel Corporation PUMA 7 C0 PLATFORM/TBD, BIOS CGM2.86C.627075.R.1910091149 10/09/2019 [71309.656650] b400bc64 813a6f95 b400bc00 c513f634 b400bc7c 810eae17 c513f634 b400bc98 [71309.665340] c513f634 a6135320 b400be9c c5056d88 c511686a b400bc98 c5116cf6 aba1e440 [71309.674047] c511948f 3a475542 746e6920 656e7265 69203a74 73616d70 46203a71 4c415441 [71309.682737] Call Trace: [71309.685464] <IRQ> [71309.687600] dump_stack+0x51/0x6c [71309.691304] panic+0x91/0x1b9 [71309.694677] dpmod_bugmsg+0x98/0xd0 [kdsldmod] [71309.699641] ? enqueue_task_fair+0x861/0xdb0 [71309.704413] ? sched_clock_cpu+0x115/0x170 [71309.708988] ? find_next_bit+0x1b/0x30 [71309.713173] ? cpumask_next_and+0x24/0x30 [71309.717650] ? update_sd_lb_stats+0x110/0x490 [71309.722515] ? number+0x3bc/0x3c0 [71309.726214] ? update_sd_lb_stats+0x420/0x490 [71309.731078] ? vsnprintf+0x32c/0x5a0 [71309.735071] ? snprintf+0x1d/0x20 [71309.738836] ? ipaddr2str+0x54/0x60 [kdsldmod] [71309.743858] masq_release+0x3e2/0x450 [kdsldmod] [71309.749016] ? _raw_spin_unlock_bh+0x13/0x20 [71309.753837] ? ctimer_unsetup_internal+0x15f/0x190 [kdsldmod] [71309.760316] masq_expire_timer+0x49/0x90 [kdsldmod] [71309.765817] ctimer_internal_docallouts+0x21e/0x340 [kdsldmod] [71309.772375] ? pcp_request_handler+0x140/0x140 [kdsldmod] [71309.778447] timer_function+0x1d/0xc0 [kdsldmod] [71309.783644] ? pcp_request_handler+0x140/0x140 [kdsldmod] [71309.789675] call_timer_fn.isra.29+0x29/0xc0 [71309.794444] ? rebalance_domains+0xe4/0x2a0 [71309.799114] run_timer_softirq+0x1b8/0x3b0 [71309.803729] ? pcp_request_handler+0x140/0x140 [kdsldmod] [71309.809759] ? run_rebalance_domains+0x118/0x1a0 [71309.814916] __do_softirq+0xf8/0x370 [71309.818908] ? takeover_tasklets+0x110/0x110 [71309.823677] do_softirq_own_stack+0x1d/0x30 [71309.828348] <EOI> [71309.830493] irq_exit+0xb5/0xc0 [71309.834002] smp_apic_timer_interrupt+0x4b/0x90 [71309.839063] apic_timer_interrupt+0x2d/0x34 [71309.843733] ? ip_tunnel_rcv.cold.38+0x34/0x40 [71309.848695] ? cpuidle_enter_state+0x14d/0x250 [71309.853656] cpuidle_enter+0xf/0x20 [71309.857552] call_cpuidle+0x1c/0x30 [71309.861445] cpu_startup_entry+0x10f/0x1a0 [71309.866019] rest_init+0x6c/0x6f [71309.869622] start_kernel+0x366/0x370 [71309.873711] i386_start_kernel+0x43/0x45 [71309.878091] Remote Queue: Len: 64 Min Free: 59 Local Queue: Len: 64 Min Free: 37 Dropped: 0 [71309.891089] set_reboot_status: Soft-Reboot(PANIC) - SHORTPOWERCUT(2) PANIC(1) DOCSIS_OPERATOR(2)SUM(5)UP(71307)UTC(1648017164)FW()HW(233)HWS(8)BV(1.3614) [71309.906641] Kernel Offset: disabled
Ist der Bug bekannt? Wird daran gearbeitet? An AVM selbst wird das melden ja wahrscheinlich schwierig, weil es sich um eine Vodafone-Leihbox handelt.
Gruß,
Lukas
Gelöst! Gehe zu Lösung.
am 29.03.2022 21:07
Hey,
der Tausch ist veranlasst. Die defekte Box sendest Du uns bitte zurück, sobald die neue angeschlossen ist. Tausch bitte auch das Netzteil.
VG Wallace
am 25.03.2022 10:46
Hallo monofox,
erst einmal herzlich willkommen in unserer Community.
Du bist der erste, der sich zu einem solchen Bug meldet. Auch intern ist uns dahingehend (noch) nichts bekannt. Ob das die Ursache für die Abstürze ist, gilt es nun herauszufinden.
Damit ich Dir helfen kann, brauch ich Deine Unterstützung. Sei so lieb und beantworte die noch offenen Fragen aus unserem Beitrag "Störung der Kabel-Internet-Dienste". Kopiere einfach die Punkte und schreibe Deine Angaben dazu.
Beste Grüße
Tina
am 25.03.2022 13:07
Hallo Tina,
vielen Dank für deine Rückmeldung. Die Panic führte tatsächlich zum Neustart.
In der Fußnote sieht man:
[71309.891089] set_reboot_status: Soft-Reboot(PANIC) - SHORTPOWERCUT(2) PANIC(1) DOCSIS_OPERATOR(2)SUM(5)UP(71307)UTC(1648017164)FW()HW(233)HWS(8)BV(1.3614)
das es seit dem letzten regulären sauberen Neustart insgesamt 2 Stromausfälle gab (die waren tatsächlich am 22.03. am Morgen) und 2 durch Vodafone (die waren eher Anfang März) und eben die Kernel Panic am 23.03.. Das kommt auch gut hin.
Die Daten:
am 26.03.2022 21:12
Hi monofox,
so richtig glaube ich nicht an einen Bug. Ich würde mir den Anschluss gern einmal anschauen. Bitte sende mir Deinen Namen, die Anschrift, Dein Geburtsdatum und Deine Kundennummer per PN und sag mir kurz hier Bescheid, wenn Du die Nachricht versendet hast.
Viele Grüße
Marco
am 27.03.2022 07:53
Hallo Marco,
PN ist raus.
Der genaue Zeitstempel vom 23.03.2022 war Wed Mar 23 06:32:44 2022 UTC (Kernel panic)
Der genaue Zeitstempel vom 28.02.2022 war Sun Feb 27 23:42:21 2022 UTC (Kernel panic)
Gestern gab ein Disconnect gegen 2022-03-26 16:00:00 CET aber das hatte eine andere Ursache (T2-T4 timeout,...).
Bei Bedarf übersende ich als PN oder E-Mail auch gerne die Supportdateien von der Fritzbox.
Viele Grüße,
Lukas
am 28.03.2022 14:34
Hey @monofox,
ich würd als erstes tatsächlich n Tausch des Gerätes vorschlagen, wollen wir das versuchen? 🙂
LG
Tobias
am 28.03.2022 16:53
Hallo @Tobias ,
vielen Dank für Deine Rückmeldung. Ich bin im Tausch geübt. Wir können das gerne so machen. Ich nehme an, ihr habt alle notwendigen Daten dafür in den Kundenstamminformationen. Ansonsten gerne noch einmal melden.
Viele Grüße,
Lukas
am 29.03.2022 21:07
Hey,
der Tausch ist veranlasst. Die defekte Box sendest Du uns bitte zurück, sobald die neue angeschlossen ist. Tausch bitte auch das Netzteil.
VG Wallace
am 01.04.2022 17:20
Hallo Wallace,
danke! Das Gerät kam heute an und die alte Box ist auf dem Weg zurück.
Gebt mir bitte 4-6 Wochen um zu schauen, ob das Verhalten noch einmal zu beobachten ist.
Viele Grüße,
Lukas
am 02.04.2022 09:12
Hallo Wallace,
die Fritzbox, die ihr mir zugeschickt habt, hat den "Freeze"-Bug.
D.h. die FRITZ!Box ist zwar noch an und Lämpchen sind grün, sie ist aber augenblicklich nicht mehr erreichbar - auch Internet ist dann nicht mehr möglich.
13: 2022-04-02 01:45:59 82000200 critical No Ranging Response received - T3 time-out
- 2022-04-02 01:48:35 2 times
14: 2022-04-02 03:50:24 90000000 warning MIMO Event MIMO: Stored MIMO=-1 post cfg file MIMO=-1
15: 2022-04-02 03:50:28 73050400 warning REG-RSP-MP Mismatch Between Calculated Value for P1.6hi Compared to CCAP Provided Value
16: 2022-04-02 03:50:28 82001200 warning RNG-RSP CCAP Commanded Power in Excess of 6 dB Below the Value Corresponding to the Top of the DRW
- 2022-04-02 03:50:28 3 times
17: 2022-04-02 04:14:32 90000000 warning MIMO Event MIMO: Stored MIMO=-1 post cfg file MIMO=-1
18: 2022-04-02 04:14:36 73050400 warning REG-RSP-MP Mismatch Between Calculated Value for P1.6hi Compared to CCAP Provided Value
19: 2022-04-02 04:14:36 82001200 warning RNG-RSP CCAP Commanded Power in Excess of 6 dB Below the Value Corresponding to the Top of the DRW
- 2022-04-02 04:14:36 3 times
20: 2022-04-02 04:33:01 82000200 critical No Ranging Response received - T3 time-out
21: 2022-04-02 06:28:03 90000000 warning MIMO Event MIMO: Stored MIMO=-1 post cfg file MIMO=-1
22: 2022-04-02 06:28:07 73050400 warning REG-RSP-MP Mismatch Between Calculated Value for P1.6hi Compared to CCAP Provided Value
23: 2022-04-02 06:28:07 82001200 warning RNG-RSP CCAP Commanded Power in Excess of 6 dB Below the Value Corresponding to the Top of the DRWD.h. ab ~ 03:50 Uhr hat die FRITZ!Box keine DHCP-Anfragen oder dergleichen mehr beantwortet und es war auch kein Internet mehr möglich:
Von 03:48 Uhr hat sie sich noch einmal erholt - aber mit einer völlig falschen internen IP-Adresse (sie ist in den FRITZ!Box-Einstellungen hart kodiert, damit eingehende IPSec-Verbindungen nachgelagert korrekt funktioniert):
Statt die .2 wurde auf einmal von der FRITZ!Box die .101 zugewiesen (DHCP beginnt ab .100).
Ab 2022-04-02 03:50:10.328 +02:00 hat die FRITZ!Box dann wieder die .2 zugewiesen und es kamen auch wieder Anfragen aus dem Internet rein. Und ab 2022-04-02 03:51:50.258 hat auch IPv6 wieder funktioniert.
Ab 04:12 Uhr war es wieder vorbei:
Und ab 2022-04-02 04:13:58.675 hat die FRITZ!Box wieder geantwortet. Jedoch wiederholte sich das Spiel mit der .101-Adresse.
Ab dem Zeitpunkt ging es in einer Endlosschleife:
Erst reagiert es nicht auf DHCPDISCOVER, dann ist plötzlich ein Link wieder da, aber nach 4 Sekunden ist wieder alles weg und die FRITZ!Box kappt die Verbindung.
Damit die FRITZ!Box wieder korrekt reagiert, muss sie komplett neugestartet werden.
Mit der letzten FRITZ!Box (also die mit dem Hashtable Bug) hatte ich den Bug nicht mehr gehabt. Ist schon eine Weile her, wo ich beim letzten Mal den Freeze-Bug hatte. Die letzte war aber auch noch Original-Neu. Die jetzige ist eine, die schon im Umlauf war.
Ihr scheint mir also eine ganze Menge an kaputten FRITZ!Boxen im Umlauf zu haben, die ihr bei Retoure nicht aussortiert.
Sollte dieser Freeze-Bug in den nächsten 4-6 Wochen noch einmal auftauchen, werden wir einen erneuten Hardwaretausch machen müssen. Dieser ist nämlich noch schlimmer als der Hashtable-Bug, weil sich die FRITZ!Box nicht automatisch neustartet.
Sollte der Kernel Panic Hashtable Bug in den nächsten 4-6 Wochen noch einmal auftauchen, müssen wir darüber sprechen, wie die Ursache ermittelt und behoben werden kann (bspw. im Zusammenspiel mit AVM).
All die Probleme kenne ich mit dem TC4400 übrigens gar nicht, weil es ein reines Modem ist und sich auf seine Kernkompetenz konzentriert. Da ihr es allerdings für den Support nicht akzeptiert und ich nicht bereit bin jedes Mal bei einer netzseitigen Störung die Box umzuklemmen und damit Routerkonfigurationsänderungen erzwingt, müsst ihr leider die FRITZ!Box-Probleme in den Griff bekommen. So gerne ich es euch auch ersparen wollen würde. ![]()
Viele Grüße und ein gutes Wochenende,
Lukas