Kernel crash

[kpoman]

Hello, I configured and am using your tool to setup NAP on my Pi3 b+. It works pretty well, however, it crashs randomly and I see:

root@IQoT-000:/home/pi# tail -f /var/log/messages
Feb 12 22:25:24 IQoT-000 kernel: [ 3016.392058] Voltage normalised (0x00000000)
Feb 12 22:27:25 IQoT-000 kernel: [ 3137.032044] Voltage normalised (0x00000000)
Feb 12 22:29:23 IQoT-000 kernel: [ 3255.592050] Voltage normalised (0x00000000)
Feb 12 22:31:24 IQoT-000 kernel: [ 3376.232052] Voltage normalised (0x00000000)
Feb 12 22:33:24 IQoT-000 kernel: [ 3496.872068] Voltage normalised (0x00000000)
Feb 12 22:33:33 IQoT-000 kernel: [ 3505.886420] br0: port 1(bnep0) entered blocking state
Feb 12 22:33:33 IQoT-000 kernel: [ 3505.886445] br0: port 1(bnep0) entered disabled state
Feb 12 22:33:33 IQoT-000 kernel: [ 3505.886859] device bnep0 entered promiscuous mode
Feb 12 22:33:33 IQoT-000 kernel: [ 3505.887938] br0: port 1(bnep0) entered blocking state
Feb 12 22:33:33 IQoT-000 kernel: [ 3505.887954] br0: port 1(bnep0) entered forwarding state
Feb 12 22:34:24 IQoT-000 kernel: [ 3556.058096] br0: port 1(bnep0) entered disabled state
Feb 12 22:34:24 IQoT-000 kernel: [ 3556.062332] device bnep0 left promiscuous mode
Feb 12 22:34:24 IQoT-000 kernel: [ 3556.062356] br0: port 1(bnep0) entered disabled state
Feb 12 22:35:05 IQoT-000 kernel: [ 3597.350916] br0: port 1(bnep0) entered blocking state
Feb 12 22:35:05 IQoT-000 kernel: [ 3597.350926] br0: port 1(bnep0) entered disabled state
Feb 12 22:35:05 IQoT-000 kernel: [ 3597.351155] device bnep0 entered promiscuous mode
Feb 12 22:35:05 IQoT-000 kernel: [ 3597.352141] br0: port 1(bnep0) entered blocking state
Feb 12 22:35:05 IQoT-000 kernel: [ 3597.352151] br0: port 1(bnep0) entered forwarding state
Feb 12 22:35:10 IQoT-000 kernel: [ 3602.952117] Voltage normalised (0x00000000)
Feb 12 22:35:23 IQoT-000 kernel: [ 3615.432055] Voltage normalised (0x00000000)
Feb 12 22:35:43 IQoT-000 kernel: [ 3635.786222] br0: port 2(bnep1) entered blocking state
Feb 12 22:35:43 IQoT-000 kernel: [ 3635.786236] br0: port 2(bnep1) entered disabled state
Feb 12 22:35:43 IQoT-000 kernel: [ 3635.786807] device bnep1 entered promiscuous mode
Feb 12 22:35:43 IQoT-000 kernel: [ 3635.788729] br0: port 2(bnep1) entered blocking state
Feb 12 22:35:43 IQoT-000 kernel: [ 3635.788745] br0: port 2(bnep1) entered forwarding state
Feb 12 22:36:11 IQoT-000 kernel: [ 3663.272042] Voltage normalised (0x00000000)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.991930] ------------[ cut here ]------------
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992001] WARNING: CPU: 1 PID: 0 at net/sched/sch_generic.c:466 dev_watchdog+0x294/0x298
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992023] NETDEV WATCHDOG: bnep0 (): transmit queue 0 timed out
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992036] Modules linked in: fuse rfcomm bridge bnep hci_uart btbcm serdev bluetooth ecdh_generic 8021q garp stp llc binfmt_misc brcmfmac brcmutil sha256_generic cfg80211 rfkill snd_bcm2835(C) raspberrypi_hwmon hwmon snd_pcm bcm2835_codec(C) snd_timer bcm2835_v4l2(C) v4l2_mem2mem snd bcm2835_mmal_vchiq(C) videobuf2_dma_contig v4l2_common videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_common videodev media vc_sm_cma(C) fixed uio_pdrv_genirq uio i2c_dev ip_tables x_tables ipv6
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992189] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G         C        4.19.93-v7+ #1290
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992195] Hardware name: BCM2835
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992238] [<801120c0>] (unwind_backtrace) from [<8010d5f4>] (show_stack+0x20/0x24)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992260] [<8010d5f4>] (show_stack) from [<808453e8>] (dump_stack+0xe0/0x124)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992279] [<808453e8>] (dump_stack) from [<80120c9c>] (__warn+0x104/0x11c)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992295] [<80120c9c>] (__warn) from [<80120d0c>] (warn_slowpath_fmt+0x58/0x74)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992313] [<80120d0c>] (warn_slowpath_fmt) from [<8076ad4c>] (dev_watchdog+0x294/0x298)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992338] [<8076ad4c>] (dev_watchdog) from [<80198fd8>] (call_timer_fn+0x3c/0x198)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992359] [<80198fd8>] (call_timer_fn) from [<80199220>] (expire_timers+0xec/0x14c)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992380] [<80199220>] (expire_timers) from [<80199338>] (run_timer_softirq+0xb8/0x1ec)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992399] [<80199338>] (run_timer_softirq) from [<80102410>] (__do_softirq+0x190/0x3f0)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992415] [<80102410>] (__do_softirq) from [<80126e24>] (irq_exit+0xfc/0x120)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992434] [<80126e24>] (irq_exit) from [<8018023c>] (__handle_domain_irq+0x70/0xc4)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992449] [<8018023c>] (__handle_domain_irq) from [<801021b4>] (bcm2836_arm_irqchip_handle_irq+0x60/0xa4)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992464] [<801021b4>] (bcm2836_arm_irqchip_handle_irq) from [<801019bc>] (__irq_svc+0x5c/0x7c)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992481] Exception stack(0xb694df38 to 0xb694df80)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992495] df20:                                                       80109ae4 00000000
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992512] df40: 40000093 40000093 80d04d70 b694c000 80d04db8 00000002 80d8efbe 410fd034
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992524] df60: 00000000 b694df94 80d0517c b694df88 00000000 80109ae8 40000013 ffffffff
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992541] [<801019bc>] (__irq_svc) from [<80109ae8>] (arch_cpu_idle+0x34/0x4c)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992564] [<80109ae8>] (arch_cpu_idle) from [<808624d4>] (default_idle_call+0x34/0x48)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992585] [<808624d4>] (default_idle_call) from [<80152e80>] (do_idle+0xec/0x16c)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992604] [<80152e80>] (do_idle) from [<801531c0>] (cpu_startup_entry+0x28/0x2c)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992621] [<801531c0>] (cpu_startup_entry) from [<8010fedc>] (secondary_start_kernel+0x134/0x140)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992636] [<8010fedc>] (secondary_start_kernel) from [<0010270c>] (0x10270c)
Feb 12 22:36:37 IQoT-000 kernel: [ 3689.992663] ---[ end trace 2432ac594065705f ]---
Feb 12 22:36:52 IQoT-000 kernel: [ 3704.349314] br0: port 2(bnep1) entered disabled state
Feb 12 22:36:52 IQoT-000 kernel: [ 3704.350863] device bnep1 left promiscuous mode
Feb 12 22:36:52 IQoT-000 kernel: [ 3704.350882] br0: port 2(bnep1) entered disabled state
Feb 12 22:36:52 IQoT-000 kernel: [ 3704.434634] br0: port 1(bnep0) entered disabled state
Feb 12 22:36:52 IQoT-000 kernel: [ 3704.436821] device bnep0 left promiscuous mode
Feb 12 22:36:52 IQoT-000 kernel: [ 3704.436839] br0: port 1(bnep0) entered disabled state

Then I get disconnected (I am connecting to my Pi both from a Linux Mint box and my android phone). If I try to restablish, it reconnects, then after a while, crashs again.

Nevermind ... If you have some time to take a look and if you need me to test anything, just let me know !

[bablokb]

HI, I am no kernel expert, so I don't think I can help. What I did do: I searched google for the error and it turns out that this seems to be a well known problem since 2011 which pops up once in a while. And it is always related to the netdev watchdog. There are some hints that point to a hardware problem, but nothing really useful.

What I do see in your log is that you have undervoltage problems. So one thing to try is a better power-supply or a better cable just to rule out that this could be the cause. N.B. I also have these messages on some of my Pis without any negative impact, but that does not mean anything because hardware and usage differs.

Bernhard