Under-voltage detected on Raspberry Pi 3

[rohitg76]

Recently I noticed the following in the startup log of my RPi3. It has coincided with rpi-update on it - hence, I am unsure as to what may have been the root cause of WiFi stopping to work, and under voltage warnings being reported, and SD card coming up at only 25Mhz.

(with following params in config.txt)
total_mem=1024
gpu_mem=64
arm_freq=1350
gpu_freq=500
core_freq=500
sdram_freq=500
sdram_schmoo=0x02000020
over_voltage=4
sdram_over_voltage=2
dtparam=sd_overclock=100

dmesg output lists the following

[ 149.911657] Under-voltage detected! (0x00050005)
[ 160.311690] Voltage normalised (0x00000000)
[ 166.551633] Under-voltage detected! (0x00050005)
[ 170.711658] Voltage normalised (0x00000000)
[ 310.071465] rpi_firmware_get_throttled: 6 callbacks suppressed
[ 310.071472] Under-voltage detected! (0x00050005)
[ 328.791509] Under-voltage detected! (0x00050005)
[ 343.351410] Under-voltage detected! (0x00050005)
[ 428.631334] rpi_firmware_get_throttled: 14 callbacks suppressed
[ 428.631341] Voltage normalised (0x00000000)
[ 457.751265] Voltage normalised (0x00000000)
[ 482.711234] Voltage normalised (0x00000000)
[ 611.671143] rpi_firmware_get_throttled: 16 callbacks suppressed
[ 611.671150] Under-voltage detected! (0x00050005)
[ 619.991053] Under-voltage detected! (0x00050005)
[ 628.311152] Under-voltage detected! (0x00050005)
[ 730.230915] rpi_firmware_get_throttled: 14 callbacks suppressed
[ 730.230921] Voltage normalised (0x00000000)

But more importantly, the WiFi proc is seeming to have trouble. Hostapd is failing to start.

[ 4.675790] usbcore: registered new interface driver uas
[ 4.725432] scsi 0:0:0:0: Direct-Access USB TO I DE/SATA Device 0016 PQ: 0 ANSI: 4
[ 4.727282] sd 0:0:0:0: [sda] 0 512-byte logical blocks: (0 B/0 B)
[ 4.727299] sd 0:0:0:0: [sda] 0-byte physical blocks
[ 4.728139] sd 0:0:0:0: [sda] Test WP failed, assume Write Enabled
[ 4.728941] sd 0:0:0:0: [sda] Asking for cache data failed
[ 4.728957] sd 0:0:0:0: [sda] Assuming drive cache: write through
[ 4.736961] sd 0:0:0:0: [sda] Attached SCSI disk
[ 4.889297] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 4.913910] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[ 4.965735] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[ 4.979833] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[ 4.979864] cfg80211: failed to load regulatory.db
[ 5.052221] brcmfmac: F1 signature read @0x18000000=0x1541a9a6
[ 5.057618] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[ 5.057926] usbcore: registered new interface driver brcmfmac
[ 5.245972] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[ 5.245985] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[ 5.249556] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[ 5.249568] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[ 5.252283] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[ 5.252385] brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-2), device may have limited channels available
[ 5.253142] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Aug 7 2017 00:46:29 version 7.45.41.46 (r666254 CY) FWID 01-f8a78378
[ 5.253842] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[ 5.253850] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[ 5.593679] usb 1-1.5: new high-speed USB device number 5 using dwc_otg

Could setting never_over_voltage=1 may have caused an irreversible change of this nature?

Any pointers appreciated. Thx.

Rohit

[P33M]

It's far more likely that you have a marginal power supply - one that has either drifted in output voltage or a slight increase in current consumption on the Pi has caused the output voltage to droop.

[rohitg76]

I am using the Stontronics psu for this. It is a 2.5A 5.1V psu and the same is able to power another RPi3 with a different SD card at the throttled voltages. No errors or warnings appearing there. I have tried removing all deviations from standard yet the same behavior with this board + sd combination. This happened after an rpi-update and I used never_over_voltage=1 when I was trying something out. Unable to see why this should brick the wifi proc. Thanks for your help.

…

On Tue, May 21, 2019, 6:02 PM P33M ***@***.***> wrote: It's far more likely that you have a marginal power supply - one that has either drifted in output voltage or a slight increase in current consumption on the Pi has caused the output voltage to droop. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub <#1142?email_source=notifications&email_token=AGD5LNGXN4HSSWOBURDCY73PWPCBPA5CNFSM4HOD57F2YY3PNVWWK3TUL52HS4DFVREXG43VMVBW63LNMVXHJKTDN5WW2ZLOORPWSZGODV3NBAQ#issuecomment-494325890>, or mute the thread <https://github.com/notifications/unsubscribe-auth/AGD5LNBR4J76CCXRRWE2SULPWPCBPANCNFSM4HOD57FQ> .

[popcornmix]

If you think this coincided with an rpi-update, then can you revert to an earlier version of firmware and see if issue disappears? See:
https://github.com/Hexxeh/rpi-firmware/commits/master

If you click on each commit the end of the url contains a git hash. Run
sudo rpi-update <hash>
to revert back to that version. Report the first version with this issue.

[rohitg76]

Thanks for the suggestion @popcornmix. I reverted back to FW level corresponding to kernel 4.9.35 and as I suspected, the voltage warnings are gone and WIFI is back working. The SD (16GB SDHC) continues to be set to 25Mhz, despite the revised parameters and old FW, which was earlier able to operate at 100Mhz after throttling, prior to rpi-update. Will incrementally up the FW level and share the FW that breaks.

[rohitg76]

That said, rpi-update to the latest FW on another RPi3 running with same psu has not introduced the under-voltage warnings or impacted WiFi proc the way it did on this board. And not sure how and why a hitherto working mSD at 100Mhz would downgrade to 25Mhz - not even run at the base HS of 50Mhz (default).

Strange mentions in dmesg which were not reported earlier (prior to rpi-update, but now even after reverting to old FW, still being reported)

[ 0.000000] Kernel command line: 8250.nr_uarts=0 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[ 0.772204] mmc-bcm2835 3f300000.mmc: could not get clk, deferring probe
[ 0.774671] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
[ 0.833792] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
[ 0.836322] mmc-bcm2835 3f300000.mmc: DMA channel allocated
[ 0.930992] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[ 0.934989] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 0.938847] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 0.943810] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[ 1.041429] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[ 1.049065] Waiting for root device /dev/mmcblk0p2...
[ 1.108725] mmc0: host does not support reading read-only switch, assuming write-enable
[ 1.114743] mmc0: Problem switching card into high-speed mode!
[ 1.117866] mmc0: new SDHC card at address 0001 (this should have also said - new high speed SDHC...)
[ 1.120647] mmcblk0: mmc0:0001 SRTR 14.9 GiB
[ 1.124871] mmcblk0: p1 p2
[ 1.140673] mmc1: new high speed SDIO card at address 0001
[ 1.151036] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 4.747745] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)

Will report more as I find more.

[popcornmix]

If you can identify the first firmware commit with the issue it may shed some light.
4.9.35 is nearly two years old. I have a recollection that under-voltage detection wasn't working a couple of years back, so you may have just stumbled upon that build.

[rohitg76]

Given there are over two years of FW upgrades available from our current level of 4.9.35, I binary folded and tried. Looks like the WIFI issue cropped from 4.19.23 onwards. The last recent stable version that I could run with WIFI not failing is 4.14.98.

For the under-voltage issue, the under-voltage alerts in dmesg are not wrong - it appears only when I switch to 1A supply, goes away when I use 2.5A. So, this is a non-issue.

For the WIFI issue, I initially thought the WIFI issue was related to an alert in red for brc43430 in dmesg, but that seems incorrect - there does not seem to be a correlation since the alert is present in 4.14.98 too but WIFI seems to be working, unlike the 4.19.23 where it did not work. I am finding it difficult to believe that no one else has hit this so far - no one upgraded to 4.19.23 (Feb 2019) and tried using WiFi on the RPi3 - that's very unlikely.

For the mSD card issue - I'm still getting "[ 2.183115] mmc0: Problem switching card into high-speed mode!" after downgrading the FW for one 16GB SDHC card (Strontium UHS1) and consistently for all, even brand new, 64GB SDXC cards (Strontium UHS1) which was previously being recognized as high-speed and able to throttle to 100Mhz. Now, even after downgrading FW back to 4.9.35, it throws up this note in dmesg and able to start at basic speed and frequency of 25Mhz. Surprisingly, other 16/32GB SDHC cards and 128/256GB SDXC cards are able to throttle to 100Mhz and 90Mhz respectively. I can understand that something is gone in the one 16GB card unable to get throttled - may have just coincided with rpi-update, but all the brand new 64GB cards also not being recognized as high-speed on this one box which was FW upgraded is a cause of worry.

For now, keeping all our boxes at 4.9.35 - as that has been stable for a long time.

[bedaniels]

Guys, I'm also having what looks like low power issues. Updated everything, checked the cables, USB power supply output, new SD card but all I see is a sea of red. Primary issue is failure to recognise the USB ports even prior to booting the OS with screen error for all four USB ports.

usb 1-1: device descriptor read/64, error -71

Finally managed to SSH and VNC into it as a head end. I think I need to revert back the RPI to an earlier vervion, but need some guidance there if this is the case. This is the mess I'm trying to decipher:

pi@raspberrypi:~ $ dmesg
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 5.4.50-v7+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1324 SMP Wed Jul 1 17:00:22 BST 2020
[ 0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
[ 0.000000] CPU: div instructions available: patching division code
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Rev 1.2
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] Reserved memory: created CMA memory pool at 0x37400000, size 64 MiB
[ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[ 0.000000] On node 0 totalpages: 242688
[ 0.000000] Normal zone: 1896 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 242688 pages, LIFO batch:63
[ 0.000000] percpu: Embedded 20 pages/cpu s49792 r8192 d23936 u81920
[ 0.000000] pcpu-alloc: s49792 r8192 d23936 u81920 alloc=20*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 240792
[ 0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 bcm2708_fb.fbwidth=1920 bcm2708_fb.fbheight=1080 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=PARTUUID=2486647e-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] Memory: 882472K/970752K available (8192K kernel code, 680K rwdata, 2532K rodata, 1024K init, 824K bss, 22744K reserved, 65536K cma-reserved)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] ftrace: allocating 27957 entries in 55 pages
[ 0.000000] rcu: Hierarchical RCU implementation.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000000] random: get_random_bytes called from start_kernel+0x328/0x4e8 with crng_init=0
[ 0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[ 0.000007] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[ 0.000019] Switching to timer-based delay loop, resolution 52ns
[ 0.000282] Console: colour dummy device 80x30
[ 0.000308] printk: console [tty1] enabled
[ 0.000362] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[ 0.000381] pid_max: default: 32768 minimum: 301
[ 0.000710] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 0.000731] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 0.001894] CPU: Testing write buffer coherency: ok
[ 0.002447] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.003380] Setting up static identity map for 0x100000 - 0x10003c
[ 0.003574] rcu: Hierarchical SRCU implementation.
[ 0.004249] smp: Bringing up secondary CPUs ...
[ 0.005356] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.006609] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[ 0.007756] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[ 0.007908] smp: Brought up 1 node, 4 CPUs
[ 0.007923] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[ 0.007933] CPU: All CPU(s) started in HYP mode.
[ 0.007942] CPU: Virtualization extensions available.
[ 0.008875] devtmpfs: initialized
[ 0.025456] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
[ 0.025727] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.025754] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[ 0.028769] pinctrl core: initialized pinctrl subsystem
[ 0.029903] NET: Registered protocol family 16
[ 0.034307] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[ 0.040676] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[ 0.040688] hw-breakpoint: maximum watchpoint size is 8 bytes.
[ 0.040932] Serial: AMBA PL011 UART driver
[ 0.042860] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[ 0.060099] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-07-02 15:01, variant start
[ 0.070113] raspberrypi-firmware soc:firmware: Firmware hash is 36c8be9515deddc9d2b1f469374f00d0a2df13f9
[ 0.121043] bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1
[ 0.123219] SCSI subsystem initialized
[ 0.123473] usbcore: registered new interface driver usbfs
[ 0.123536] usbcore: registered new interface driver hub
[ 0.123663] usbcore: registered new device driver usb
[ 0.125784] clocksource: Switched to clocksource arch_sys_counter
[ 1.289155] VFS: Disk quotas dquot_6.6.0
[ 1.289274] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 1.289452] FS-Cache: Loaded
[ 1.289720] CacheFiles: Loaded
[ 1.300973] thermal_sys: Registered thermal governor 'step_wise'
[ 1.301349] NET: Registered protocol family 2
[ 1.302250] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
[ 1.302290] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[ 1.302405] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 1.302594] TCP: Hash tables configured (established 8192 bind 8192)
[ 1.302757] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[ 1.302809] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[ 1.303097] NET: Registered protocol family 1
[ 1.303886] RPC: Registered named UNIX socket transport module.
[ 1.303897] RPC: Registered udp transport module.
[ 1.303906] RPC: Registered tcp transport module.
[ 1.303916] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 1.305921] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
[ 1.309154] Initialise system trusted keyrings
[ 1.309389] workingset: timestamp_bits=30 max_order=18 bucket_order=0
[ 1.319880] FS-Cache: Netfs 'nfs' registered for caching
[ 1.320530] NFS: Registering the id_resolver key type
[ 1.320570] Key type id_resolver registered
[ 1.320580] Key type id_legacy registered
[ 1.320601] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[ 1.321820] Key type asymmetric registered
[ 1.321833] Asymmetric key parser 'x509' registered
[ 1.321882] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[ 1.321895] io scheduler mq-deadline registered
[ 1.321906] io scheduler kyber registered
[ 1.326826] bcm2708_fb soc:fb: FB found 1 display(s)
[ 1.365620] Console: switching to colour frame buffer device 240x67
[ 1.400844] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 1920x1080
[ 1.404669] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
[ 1.407146] bcm2835-rng 3f104000.rng: hwrng registered
[ 1.407695] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[ 1.408339] vc-sm: Videocore shared memory driver
[ 1.408831] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[ 1.420449] brd: module loaded
[ 1.432447] loop: module loaded
[ 1.433828] Loading iSCSI transport class v2.0-870.
[ 1.434785] libphy: Fixed MDIO Bus: probed
[ 1.434914] usbcore: registered new interface driver lan78xx
[ 1.434979] usbcore: registered new interface driver smsc95xx
[ 1.435004] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[ 2.163270] Core Release: 2.80a
[ 2.163286] Setting default values for core params
[ 2.163323] Finished setting default values for core params
[ 2.363702] Using Buffer DMA mode
[ 2.363714] Periodic Transfer Interrupt Enhancement - disabled
[ 2.363724] Multiprocessor Interrupt Enhancement - disabled
[ 2.363734] OTG VER PARAM: 0, OTG VER FLAG: 0
[ 2.363750] Dedicated Tx FIFOs mode
[ 2.364385] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b7504000 dma = 0xf7504000 len=9024
[ 2.364419] FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
[ 2.364430] dwc_otg: Microframe scheduler enabled
[ 2.364502] WARN::hcd_init_fiq:457: FIQ on core 1
[ 2.364514] WARN::hcd_init_fiq:458: FIQ ASM at 806bd860 length 36
[ 2.364524] WARN::hcd_init_fiq:497: MPHI regs_base at bb810000
[ 2.364548] dwc_otg 3f980000.usb: DWC OTG Controller
[ 2.364589] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[ 2.364648] dwc_otg 3f980000.usb: irq 56, io mem 0x00000000
[ 2.364701] Init: Port Power? op_state=1
[ 2.364710] Init: Power Port (0)
[ 2.365064] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
[ 2.365080] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 2.365094] usb usb1: Product: DWC OTG Controller
[ 2.365108] usb usb1: Manufacturer: Linux 5.4.50-v7+ dwc_otg_hcd
[ 2.365122] usb usb1: SerialNumber: 3f980000.usb
[ 2.365909] hub 1-0:1.0: USB hub found
[ 2.365975] hub 1-0:1.0: 1 port detected
[ 2.366779] dwc_otg: FIQ enabled
[ 2.366789] dwc_otg: NAK holdoff enabled
[ 2.366798] dwc_otg: FIQ split-transaction FSM enabled
[ 2.366814] Module dwc_common_port init
[ 2.367163] usbcore: registered new interface driver usb-storage
[ 2.367404] mousedev: PS/2 mouse device common for all mice
[ 2.368916] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[ 2.371159] sdhci: Secure Digital Host Controller Interface driver
[ 2.371170] sdhci: Copyright(c) Pierre Ossman
[ 2.371743] mmc-bcm2835 3f300000.mmcnr: could not get clk, deferring probe
[ 2.372342] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
[ 2.372574] sdhci-pltfm: SDHCI platform and OF driver helper
[ 2.374389] ledtrig-cpu: registered to indicate activity on CPUs
[ 2.374596] hidraw: raw HID events driver (C) Jiri Kosina
[ 2.374789] usbcore: registered new interface driver usbhid
[ 2.374798] usbhid: USB HID core driver
[ 2.375959] vchiq: vchiq_init_state: slot_zero = (ptrval)
[ 2.377859] [vc_sm_connected_init]: start
[ 2.387759] [vc_sm_connected_init]: end - returning 0
[ 2.389564] Initializing XFRM netlink socket
[ 2.389602] NET: Registered protocol family 17
[ 2.389743] Key type dns_resolver registered
[ 2.390591] Registering SWP/SWPB emulation handler
[ 2.390942] registered taskstats version 1
[ 2.390964] Loading compiled-in X.509 certificates
[ 2.391454] Key type ._fscrypt registered
[ 2.391465] Key type .fscrypt registered
[ 2.402004] uart-pl011 3f201000.serial: cts_event_workaround enabled
[ 2.402098] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 81, base_baud = 0) is a PL011 rev2
[ 2.404612] printk: console [ttyS0] disabled
[ 2.404694] 3f215040.serial: ttyS0 at MMIO 0x0 (irq = 53, base_baud = 50000000) is a 16550
[ 2.404768] printk: console [ttyS0] enabled
[ 2.405486] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[ 2.407063] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0
[ 2.407077] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated
[ 2.435710] sdhost: log_buf @ (ptrval) (f7507000)
[ 2.473703] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[ 2.475332] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 2.477006] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[ 2.479951] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[ 2.485750] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[ 2.488412] of_cfs_init
[ 2.488686] of_cfs_init: OK
[ 2.506668] Waiting for root device PARTUUID=2486647e-02...
[ 2.546648] random: fast init done
[ 2.575223] mmc0: host does not support reading read-only switch, assuming write-enable
[ 2.578967] mmc0: new high speed SDHC card at address aaaa
[ 2.580026] mmcblk0: mmc0:aaaa SC32G 29.7 GiB
[ 2.583665] mmcblk0: p1 p2
[ 2.585996] Indeed it is in host mode hprt0 = 00021501
[ 2.660293] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 2.660381] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[ 2.660736] mmc1: new high speed SDIO card at address 0001
[ 2.661267] devtmpfs: mounted
[ 2.668267] Freeing unused kernel memory: 1024K
[ 2.686209] Run /sbin/init as init process
[ 2.795853] usb 1-1: new full-speed USB device number 2 using dwc_otg
[ 2.796343] Indeed it is in host mode hprt0 = 00021501
[ 3.005842] usb 1-1: device descriptor read/64, error -71
[ 3.126434] Indeed it is in host mode hprt0 = 00021501
[ 3.335852] usb 1-1: device descriptor read/64, error -71
[ 3.455968] Indeed it is in host mode hprt0 = 00021501
[ 3.520902] systemd[1]: System time before build time, advancing clock.
[ 3.665895] usb 1-1: new full-speed USB device number 3 using dwc_otg
[ 3.666447] Indeed it is in host mode hprt0 = 00021501
[ 3.672167] NET: Registered protocol family 10
[ 3.673536] Segment Routing with IPv6
[ 3.770698] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[ 3.771680] systemd[1]: Detected architecture arm.
[ 3.830659] systemd[1]: Set hostname to .
[ 3.876208] usb 1-1: device descriptor read/64, error -71
[ 4.006561] Indeed it is in host mode hprt0 = 00021501
[ 4.235857] usb 1-1: device descriptor read/64, error -71
[ 4.355990] usb usb1-port1: attempt power cycle
[ 4.905598] random: systemd: uninitialized urandom read (16 bytes read)
[ 4.951136] systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
[ 4.951286] random: systemd: uninitialized urandom read (16 bytes read)
[ 4.952076] systemd[1]: Listening on fsck to fsckd communication Socket.
[ 4.952393] random: systemd: uninitialized urandom read (16 bytes read)
[ 4.960431] systemd[1]: Listening on Syslog Socket.
[ 4.962432] systemd[1]: Created slice User and Session Slice.
[ 4.962880] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 4.965155] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[ 4.966084] systemd[1]: Listening on udev Control Socket.
[ 5.146815] i2c /dev entries driver
[ 5.719139] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ 5.832495] systemd-journald[107]: Received request to flush runtime journal from PID 1
[ 6.526137] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.534062] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[ 6.534101] [vc_sm_connected_init]: start
[ 6.540441] [vc_sm_connected_init]: installed successfully
[ 6.545292] mc: Linux media interface: v0.10
[ 6.616582] videodev: Linux video capture interface: v2.00
[ 6.627227] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.646592] bcm2835_audio bcm2835_audio: card created with 4 channels
[ 6.657452] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.658635] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.659665] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.670733] bcm2835_audio bcm2835_audio: card created with 4 channels
[ 6.673407] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.675480] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.680967] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[ 6.706964] bcm2835-isp bcm2835-isp: bcm2835_isp_get_supported_fmts: port has more encoding than we provided space for. Some are dropped.
[ 6.708819] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[ 6.710034] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[ 6.710749] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[ 6.710784] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[ 6.710908] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[ 6.711379] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[ 6.711429] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[ 6.711452] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[ 6.711471] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[ 6.711488] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[ 6.711768] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[ 6.737708] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[ 6.737893] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[ 6.751508] : bcm2835_codec_get_supported_fmts: port has more encoding than we provided space for. Some are dropped.
[ 6.753733] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[ 6.753911] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[ 7.195304] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[ 7.343096] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[ 7.444010] brcmfmac: F1 signature read @0x18000000=0x1541a9a6
[ 7.456111] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[ 7.456413] usbcore: registered new interface driver brcmfmac
[ 7.494058] brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43430-sdio.raspberrypi,3-model-b.txt failed with error -2
[ 7.702136] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[ 7.702273] brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-2), device may have limited channels available
[ 7.703213] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Oct 22 2019 01:59:28 version 7.45.98.94 (r723000 CY) FWID 01-3b33decd
[ 9.035933] Under-voltage detected! (0x00050005)
[ 10.110760] random: crng init done
[ 10.110805] random: 7 urandom warning(s) missed due to ratelimiting
[ 10.415117] 8021q: 802.1Q VLAN Support v1.8
[ 10.983006] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[ 11.065983] Adding 102396k swap on /var/swap. Priority:-2 extents:1 across:102396k SSFS
[ 12.787375] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 18.899411] fuse: init (API version 7.31)
[ 31.915911] Voltage normalised (0x00000000)
[ 40.235938] Under-voltage detected! (0x00050005)
[ 48.353686] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.wlan0.retrans_time - use net.ipv6.neigh.wlan0.retrans_time_ms instead

Any advice appreciated or you think the HW is just screwed?

Cheers.

Ben.

[popcornmix]

Closing this issue are original bug was due to an insufficient power supply.
@bedaniels you are best off posting on the forum, as this is very unlikely to be a firmware issue. You almost certainly have voltage drop across your cables and the solution will be power supply or power supply USB cable related.