raspberrypi / linux

Kernel source tree for Raspberry Pi-provided kernel builds. Issues unrelated to the linux kernel should be posted on the community forum at https://forums.raspberrypi.com/
Other
11.05k stars 4.96k forks source link

Wifi on Zero W shows kernel backtrace in dmesg related to cfg80211 - iwconfig says not connected, but device is connected #5345

Open jeremyherbert opened 1 year ago

jeremyherbert commented 1 year ago

Describe the bug

iwconfig reports that the network is not connected:

$ iwconfig
lo        no wireless extensions.

wlan0     IEEE 802.11  ESSID:off/any
          Mode:Managed  Access Point: Not-Associated   Tx-Power=31 dBm
          Retry short limit:7   RTS thr:off   Fragment thr:off
          Power Management:on

iwgetid is incorrect as the network does have an SSID:

$ iwgetid
wlan0     ESSID:""

However, the device is connected (I can ssh into it) and ip a reports that an IP has been allocated:

$ 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: wlan0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000
    link/ether b8:27:eb:74:e3:20 brd ff:ff:ff:ff:ff:ff
    inet 10.180.198.124/21 brd 10.180.199.255 scope global dynamic noprefixroute wlan0
       valid_lft 1957sec preferred_lft 1507sec
    inet6 fe80::eb05:efdb:afb7:440e/64 scope link
       valid_lft forever preferred_lft forever

A backtrace is present in dmesg, see the logs section below.

I have a systemd service which reboots the device after 5 minutes if it sees this problem. Eventually after 1-3 reboots this problem appears to be resolved.

Steps to reproduce the behaviour

Unsure - this seems to happen on startup when connecting to a wifi network for some devices. Inserting the same SD card into different RPis shows that some are more likely to have this issue, while some never show it.

Device (s)

Raspberry Pi Zero W / WH

System

Raspberry Pi reference 2022-09-22 Generated using pi-gen, https://github.com/RPi-Distro/pi-gen, 8a42abcd1dbd8c9c1fdfca4e0c3778255b2f9cc4, stage2

Jan 5 2023 10:48:31 Copyright (c) 2012 Broadcom version 8ba17717fbcedd4c3b6d4bce7e50c7af4155cba9 (clean) (release) (start)

Linux wifi-b827eb74e320 5.15.84+ #1613 Thu Jan 5 11:58:09 GMT 2023 armv6l GNU/Linux

Logs

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 5.15.84+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1613 Thu Jan 5 11:58:09 GMT 2023
[    0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi Zero W Rev 1.1
[    0.000000] random: crng init done
[    0.000000] Memory policy: Data cache writeback
[    0.000000] Reserved memory: created CMA memory pool at 0x0bc00000, size 256 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000000000-0x000000001bffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000001bffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000001bffffff]
[    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.000000] pcpu-alloc: [0] 0
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 113680
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 video=Composite-1:720x480@60i smsc95xx.macaddr=B8:27:EB:21:B6:75 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000  console=ttyS0,115200 console=tty1 root=PARTUUID=5a89280e-02 rootfstype=ext4 fsck.repair=yes rootwait
[    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 177176K/458752K available (9041K kernel code, 1335K rwdata, 2948K rodata, 436K init, 546K bss, 19432K reserved, 262144K cma-reserved)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] ftrace: allocating 31903 entries in 94 pages
[    0.000000] ftrace: allocated 94 pages with 5 groups
[    0.000000] trace event string verifier disabled
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000005] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[    0.000088] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[    0.000187] bcm2835: system timer (irq = 27)
[    0.001041] Console: colour dummy device 80x30
[    0.001674] printk: console [tty1] enabled
[    0.001775] Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
[    0.060340] pid_max: default: 32768 minimum: 301
[    0.060585] LSM: Security Framework initializing
[    0.060910] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.060990] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.063086] cgroup: Disabling memory control group subsystem
[    0.063526] CPU: Testing write buffer coherency: ok
[    0.065786] Setting up static identity map for 0x8220 - 0x8258
[    0.067198] devtmpfs: initialized
[    0.080401] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
[    0.080793] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.080885] futex hash table entries: 256 (order: -1, 3072 bytes, linear)
[    0.118637] pinctrl core: initialized pinctrl subsystem
[    0.120881] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.125561] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.131807] audit: initializing netlink subsys (disabled)
[    0.133346] thermal_sys: Registered thermal governor 'step_wise'
[    0.134315] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
[    0.134415] hw-breakpoint: maximum watchpoint size is 4 bytes.
[    0.134712] Serial: AMBA PL011 UART driver
[    0.140915] audit: type=2000 audit(0.130:1): state=initialized audit_enabled=0 res=1
[    0.147941] bcm2835-mbox 2000b880.mailbox: mailbox enabled
[    0.180917] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-01-05T10:48:31, variant start
[    0.190950] raspberrypi-firmware soc:firmware: Firmware hash is 8ba17717fbcedd4c3b6d4bce7e50c7af4155cba9
[    0.247670] Kprobes globally optimized
[    0.257992] bcm2835-dma 20007000.dma: DMA legacy API manager, dmachans=0x1
[    0.261340] SCSI subsystem initialized
[    0.261875] usbcore: registered new interface driver usbfs
[    0.262028] usbcore: registered new interface driver hub
[    0.262181] usbcore: registered new device driver usb
[    0.262724] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.263088] usb_phy_generic phy: dummy supplies not allowed for exclusive requests
[    0.263579] pps_core: LinuxPPS API ver. 1 registered
[    0.263634] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.263726] PTP clock support registered
[    0.266444] clocksource: Switched to clocksource timer
[    0.346349] VFS: Disk quotas dquot_6.6.0
[    0.346630] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.346918] FS-Cache: Loaded
[    0.347306] CacheFiles: Loaded
[    0.348368] simple-framebuffer 1eaa9000.framebuffer: framebuffer at 0x1eaa9000, 0x151800 bytes
[    0.348455] simple-framebuffer 1eaa9000.framebuffer: format=a8r8g8b8, mode=720x480x32, linelength=2880
[    2.227011] Console: switching to colour frame buffer device 90x30
[    2.236139] simple-framebuffer 1eaa9000.framebuffer: fb0: simplefb registered!
[    2.258087] NET: Registered PF_INET protocol family
[    2.262048] IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    2.267401] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear)
[    2.274750] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    2.278876] TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear)
[    2.282986] TCP bind hash table entries: 4096 (order: 2, 16384 bytes, linear)
[    2.287133] TCP: Hash tables configured (established 4096 bind 4096)
[    2.291349] UDP hash table entries: 256 (order: 0, 4096 bytes, linear)
[    2.295412] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes, linear)
[    2.299947] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    2.305298] RPC: Registered named UNIX socket transport module.
[    2.309415] RPC: Registered udp transport module.
[    2.313339] RPC: Registered tcp transport module.
[    2.317208] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    2.322846] armv6-pmu arm-pmu: hw perfevents: no irqs for PMU, sampling events not supported
[    2.330783] hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
[    2.382832] Initialise system trusted keyrings
[    2.387605] workingset: timestamp_bits=14 max_order=17 bucket_order=3
[    2.404459] zbud: loaded
[    2.411490] FS-Cache: Netfs 'nfs' registered for caching
[    2.416824] NFS: Registering the id_resolver key type
[    2.420867] Key type id_resolver registered
[    2.424689] Key type id_legacy registered
[    2.428848] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    2.432673] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    2.438517] Key type asymmetric registered
[    2.442278] Asymmetric key parser 'x509' registered
[    2.446052] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    2.449810] io scheduler mq-deadline registered
[    2.453400] io scheduler kyber registered
[    2.467955] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
[    2.475143] bcm2835-rng 20104000.rng: hwrng registered
[    2.479649] vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB)
[    2.488948] gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
[    2.514245] brd: module loaded
[    2.530902] loop: module loaded
[    2.535907] Loading iSCSI transport class v2.0-870.
[    2.542519] usbcore: registered new interface driver smsc95xx
[    2.546342] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    2.550471] dwc_otg: FIQ enabled
[    2.550499] dwc_otg: NAK holdoff enabled
[    2.550515] dwc_otg: FIQ split-transaction FSM enabled
[    2.550541] Module dwc_common_port init
[    2.550996] usbcore: registered new interface driver usb-storage
[    2.555124] mousedev: PS/2 mouse device common for all mice
[    2.562670] sdhci: Secure Digital Host Controller Interface driver
[    2.566334] sdhci: Copyright(c) Pierre Ossman
[    2.570583] sdhci-pltfm: SDHCI platform and OF driver helper
[    2.575921] ledtrig-cpu: registered to indicate activity on CPUs
[    2.580440] hid: raw HID events driver (C) Jiri Kosina
[    2.584399] usbcore: registered new interface driver usbhid
[    2.588099] usbhid: USB HID core driver
[    2.599373] Initializing XFRM netlink socket
[    2.603371] NET: Registered PF_PACKET protocol family
[    2.607210] Key type dns_resolver registered
[    2.611699] registered taskstats version 1
[    2.615107] Loading compiled-in X.509 certificates
[    2.634728] uart-pl011 20201000.serial: cts_event_workaround enabled
[    2.638650] 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
[    2.648374] bcm2835-aux-uart 20215040.serial: there is not valid maps for state default
[    2.652970] printk: console [ttyS0] disabled
[    2.656734] 20215040.serial: ttyS0 at MMIO 0x20215040 (irq = 53, base_baud = 50000000) is a 16550
[    3.507305] printk: console [ttyS0] enabled
[    3.517549] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    3.528543] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    3.542170] mmc-bcm2835 20300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    3.552131] mmc-bcm2835 20300000.mmcnr: DMA channel allocated
[    3.593318] sdhost: log_buf @ df295d81 (8bd42000)
[    3.649962] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    3.683054] of_cfs_init
[    3.690159] of_cfs_init: OK
[    3.701736] Waiting for root device PARTUUID=5a89280e-02...
[    3.770922] mmc0: host does not support reading read-only switch, assuming write-enable
[    3.788717] mmc0: new high speed SDHC card at address aaaa
[    3.799930] mmcblk0: mmc0:aaaa SC32G 29.7 GiB
[    3.816392]  mmcblk0: p1 p2
[    3.824340] mmcblk0: mmc0:aaaa SC32G 29.7 GiB (quirks 0x00004000)
[    3.850862] mmc1: new high speed SDIO card at address 0001
[    3.873553] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
[    3.884954] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
[    4.163569] EXT4-fs (mmcblk0p2): recovery complete
[    4.177407] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
[    4.194681] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    4.217903] devtmpfs: mounted
[    4.231043] Freeing unused kernel image (initmem) memory: 436K
[    4.240638] Kernel memory protection not selected by kernel config.
[    4.250755] Run /sbin/init as init process
[    4.258496]   with arguments:
[    4.258518]     /sbin/init
[    4.258535]   with environment:
[    4.258547]     HOME=/
[    4.258560]     TERM=linux
[    4.846639] systemd[1]: System time before build time, advancing clock.
[    5.185699] NET: Registered PF_INET6 protocol family
[    5.196898] Segment Routing with IPv6
[    5.204332] In-situ OAM (IOAM) with IPv6
[    5.328809] systemd[1]: systemd 247.3-7+rpi1+deb11u1 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified)
[    5.365415] systemd[1]: Detected architecture arm.
[    5.410712] systemd[1]: Set hostname to <wifi-b827eb74e320>.
[    8.292476] systemd[1]: Queued start job for default target Multi-User System.
[    8.318198] systemd[1]: Created slice system-getty.slice.
[    8.335583] systemd[1]: Created slice system-modprobe.slice.
[    8.353002] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    8.371025] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    8.388602] systemd[1]: Created slice User and Session Slice.
[    8.404275] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    8.422440] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    8.441943] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    8.466381] systemd[1]: Reached target Local Encrypted Volumes.
[    8.482871] systemd[1]: Reached target Network (Pre).
[    8.498088] systemd[1]: Reached target Paths.
[    8.512656] systemd[1]: Reached target Slices.
[    8.527206] systemd[1]: Reached target Swap.
[    8.543244] systemd[1]: Listening on Syslog Socket.
[    8.559169] systemd[1]: Listening on fsck to fsckd communication Socket.
[    8.576223] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    8.594856] systemd[1]: Listening on Journal Audit Socket.
[    8.611689] systemd[1]: Listening on Journal Socket (/dev/log).
[    8.628896] systemd[1]: Listening on Journal Socket.
[    8.648409] systemd[1]: Listening on udev Control Socket.
[    8.664218] systemd[1]: Listening on udev Kernel Socket.
[    8.680518] systemd[1]: Condition check resulted in Huge Pages File System being skipped.
[    8.705785] systemd[1]: Mounting POSIX Message Queue File System...
[    8.756096] systemd[1]: Mounting RPC Pipe File System...
[    8.810906] systemd[1]: Mounting Kernel Debug File System...
[    8.870266] systemd[1]: Mounting Kernel Trace File System...
[    8.902141] systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped.
[    8.942517] systemd[1]: Starting Restore / save the current clock...
[    8.991085] systemd[1]: Starting Set the console keyboard layout...
[    9.078592] systemd[1]: Starting Create list of static device nodes for the current kernel...
[    9.195752] systemd[1]: Starting Load Kernel Module configfs...
[    9.268262] systemd[1]: Starting Load Kernel Module drm...
[    9.358359] systemd[1]: Starting Load Kernel Module fuse...
[    9.437341] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
[    9.548312] systemd[1]: Starting File System Check on Root Device...
[    9.738402] systemd[1]: Starting Journal Service...
[    9.773280] fuse: init (API version 7.34)
[    9.889896] systemd[1]: Starting Load Kernel Modules...
[   10.038312] systemd[1]: Starting Coldplug All udev Devices...
[   10.327117] systemd[1]: Mounted POSIX Message Queue File System.
[   10.455275] systemd[1]: Mounted RPC Pipe File System.
[   10.552606] systemd[1]: Mounted Kernel Debug File System.
[   10.643666] systemd[1]: Mounted Kernel Trace File System.
[   10.796747] systemd[1]: Finished Restore / save the current clock.
[   10.896842] systemd[1]: Finished Create list of static device nodes for the current kernel.
[   10.995025] systemd[1]: modprobe@configfs.service: Succeeded.
[   11.077069] systemd[1]: Finished Load Kernel Module configfs.
[   11.123305] systemd[1]: modprobe@drm.service: Succeeded.
[   11.196684] systemd[1]: Finished Load Kernel Module drm.
[   11.258551] systemd[1]: modprobe@fuse.service: Succeeded.
[   11.296953] systemd[1]: Finished Load Kernel Module fuse.
[   11.356893] systemd[1]: Finished File System Check on Root Device.
[   11.477458] systemd[1]: Mounting FUSE Control File System...
[   11.569842] dwc2 20980000.usb: supply vusb_d not found, using dummy regulator
[   11.627067] dwc2 20980000.usb: supply vusb_a not found, using dummy regulator
[   11.686534] systemd[1]: Mounting Kernel Configuration File System...
[   11.896728] dwc2 20980000.usb: EPs: 8, dedicated fifos, 4080 entries in SPRAM
[   11.917141] systemd[1]: Started File System Check Daemon to report status.
[   11.967553] dwc2 20980000.usb: DWC OTG Controller
[   12.016669] dwc2 20980000.usb: new USB bus registered, assigned bus number 1
[   12.050310] systemd[1]: Starting Remount Root and Kernel File Systems...
[   12.087210] dwc2 20980000.usb: irq 33, io mem 0x20980000
[   12.136385] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15
[   12.152925] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   12.164492] usb usb1: Product: DWC OTG Controller
[   12.173390] usb usb1: Manufacturer: Linux 5.15.84+ dwc2_hsotg
[   12.183346] usb usb1: SerialNumber: 20980000.usb
[   12.271089] systemd[1]: Started Journal Service.
[   12.476910] hub 1-0:1.0: USB hub found
[   12.526567] hub 1-0:1.0: 1 port detected
[   12.879639] g_serial gadget: Gadget Serial v2.4
[   12.888111] g_serial gadget: g_serial ready
[   12.895908] dwc2 20980000.usb: bound driver g_serial
[   13.206826] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null). Quota mode: none.
[   13.783852] systemd-journald[102]: Received client request to flush runtime journal.
[   19.177485] mc: Linux media interface: v0.10
[   19.326278] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[   19.347314] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[   19.347380] [vc_sm_connected_init]: start
[   19.377121] [vc_sm_connected_init]: installed successfully
[   20.477316] videodev: Linux video capture interface: v2.00
[   20.747836] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[   20.750307] bcm2835_audio bcm2835_audio: there is not valid maps for state default
[   21.267532] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[   21.278439] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[   21.281615] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[   21.365919] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[   21.562272] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[   21.562832] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[   21.587875] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[   21.593544] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[   21.617144] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[   21.617217] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[   21.617262] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[   21.617297] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[   21.617330] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[   21.658612] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
[   21.692515] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
[   21.707943] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
[   21.716076] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[   21.726698] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
[   21.726775] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[   21.726822] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[   21.726856] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[   21.726898] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[   21.731210] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[   21.976685] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[   21.976803] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[   21.991731] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[   21.991823] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[   22.030150] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[   22.030244] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[   22.049319] bcm2835-codec bcm2835-codec: Device registered as /dev/video18
[   22.049411] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
[   22.067354] bcm2835-codec bcm2835-codec: Device registered as /dev/video31
[   22.067485] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
[   27.750073] 8021q: 802.1Q VLAN Support v1.8
[   28.817543] uart-pl011 20201000.serial: no DMA platform data
[   29.189849] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[   30.362772] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[   31.257831] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[   31.273641] cfg80211: loaded regulatory.db is malformed or signature is missing/invalid
[   33.766604] cam-dummy-reg: disabling
[   34.672393] Bluetooth: Core ver 2.22
[   34.672582] NET: Registered PF_BLUETOOTH protocol family
[   34.672602] Bluetooth: HCI device and connection manager initialized
[   34.672638] Bluetooth: HCI socket layer initialized
[   34.672662] Bluetooth: L2CAP socket layer initialized
[   34.672707] Bluetooth: SCO socket layer initialized
[   34.734942] Bluetooth: HCI UART driver ver 2.3
[   34.734990] Bluetooth: HCI UART protocol H4 registered
[   34.735135] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   34.735481] Bluetooth: HCI UART protocol Broadcom registered
[   35.116588] tun: Universal TUN/TAP device driver, 1.6
[   35.602396] brcmfmac: F1 signature read @0x18000000=0x1541a9a6
[   35.880340] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[   35.882409] usbcore: registered new interface driver brcmfmac
[   36.141146] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
[   36.154379] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897
[   37.362825] checking generic (1eaa9000 151800) vs hw (0 ffffffff)
[   37.362875] fb0: switching to vc4 from simple
[   37.363654] Console: switching to colour dummy device 80x30
[   37.415038] vc4-drm soc:gpu: bound 20400000.hvs (ops vc4_hvs_ops [vc4])
[   37.466950] Registered IR keymap rc-cec
[   37.467280] rc rc0: vc4 as /devices/platform/soc/20902000.hdmi/rc/rc0
[   37.467597] input: vc4 as /devices/platform/soc/20902000.hdmi/rc/rc0/input0
[   37.585589] vc4-drm soc:gpu: bound 20902000.hdmi (ops vc4_hdmi_ops [vc4])
[   37.622328] vc4-drm soc:gpu: bound 20004000.txp (ops vc4_txp_ops [vc4])
[   37.623213] vc4-drm soc:gpu: bound 20206000.pixelvalve (ops vc4_crtc_ops [vc4])
[   37.623996] vc4-drm soc:gpu: bound 20207000.pixelvalve (ops vc4_crtc_ops [vc4])
[   37.670215] vc4-drm soc:gpu: bound 20807000.pixelvalve (ops vc4_crtc_ops [vc4])
[   37.670955] vc4-drm soc:gpu: bound 20c00000.v3d (ops vc4_v3d_ops [vc4])
[   37.771581] [drm] Initialized vc4 0.0.0 20140616 for soc:gpu on minor 0
[   37.865191] vc4-drm soc:gpu: [drm] Cannot find any crtc or sizes
[   39.687317] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   39.687359] Bluetooth: BNEP filters: protocol multicast
[   39.687394] Bluetooth: BNEP socket layer initialized
[   39.839860] NET: Registered PF_ALG protocol family
[   42.159805] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[   43.740705] ------------[ cut here ]------------
[   43.740741] WARNING: CPU: 0 PID: 41 at net/wireless/sme.c:756 __cfg80211_connect_result+0x434/0x4d0 [cfg80211]
[   43.743201] Modules linked in: cmac algif_hash aes_arm aes_generic ecb algif_skcipher af_alg bnep vc4 nfnetlink brcmfmac tun hci_uart btbcm bluetooth ecdh_generic ecc libaes snd_soc_hdmi_codec cec drm_kms_helper brcmutil sha256_generic libsha256 cfg80211 8021q garp stp llc snd_soc_core snd_compress snd_pcm_dmaengine syscopyarea bcm2835_codec(C) raspberrypi_hwmon sysfillrect sysimgblt bcm2835_v4l2(C) fb_sys_fops bcm2835_isp(C) v4l2_mem2mem rfkill bcm2835_mmal_vchiq(C) i2c_bcm2835 videobuf2_vmalloc videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 snd_bcm2835(C) videobuf2_common snd_pcm videodev snd_timer snd vc_sm_cma(C) mc fixed uio_pdrv_genirq uio usb_f_acm u_serial g_serial libcomposite dwc2 roles drm fuse drm_panel_orientation_quirks backlight ip_tables x_tables ipv6
[   43.743851] CPU: 0 PID: 41 Comm: kworker/u2:2 Tainted: G         C        5.15.84+ #1613
[   43.743878] Hardware name: BCM2835
[   43.743896] Workqueue: cfg80211 cfg80211_event_work [cfg80211]
[   43.746330] Backtrace:
[   43.746352] [<c08cc38c>] (dump_backtrace) from [<c08cc5d4>] (show_stack+0x20/0x24)
[   43.746422]  r7:000002f4 r6:00000009 r5:bf5e4050 r4:c0add43c
[   43.746575] [<c08cc5b4>] (show_stack) from [<c08cfb78>] (dump_stack_lvl+0x24/0x28)
[   43.746630] [<c08cfb54>] (dump_stack_lvl) from [<c08cfb90>] (dump_stack+0x14/0x1c)
[   43.746661]  r5:bf5e4050 r4:bf6135e4
[   43.746673] [<c08cfb7c>] (dump_stack) from [<c0024988>] (__warn+0xe8/0x110)
[   43.746711] [<c00248a0>] (__warn) from [<c08ccb50>] (warn_slowpath_fmt+0x68/0xd8)
[   43.746751]  r7:00000009 r6:bf5e4050 r5:000002f4 r4:bf6135e4
[   43.746762] [<c08ccaec>] (warn_slowpath_fmt) from [<bf5e4050>] (__cfg80211_connect_result+0x434/0x4d0 [cfg80211])
[   43.749226]  r9:00000100 r8:c1227e74 r7:c0c2f028 r6:00000000 r5:c789e60c r4:c3c9a004
[   43.749243] [<bf5e3c1c>] (__cfg80211_connect_result [cfg80211]) from [<bf5b2cc8>] (cfg80211_process_wdev_events+0x14c/0x1ac [cfg80211])
[   43.754046]  r8:c3c9a08c r7:c3c9a028 r6:c3c9a004 r5:c789e600 r4:20000113
[   43.754062] [<bf5b2b7c>] (cfg80211_process_wdev_events [cfg80211]) from [<bf5b2d5c>] (cfg80211_process_rdev_events+0x34/0x48 [cfg80211])
[   43.758991]  r10:c5f2c0c0 r9:c19b0905 r8:00000000 r7:c19b0900 r6:00000040 r5:c5f2c448
[   43.759017]  r4:c3c9a004
[   43.759029] [<bf5b2d28>] (cfg80211_process_rdev_events [cfg80211]) from [<bf5ac1c8>] (cfg80211_event_work+0x2c/0x38 [cfg80211])
[   43.763843]  r5:c5f2c0bc r4:c5f2c1a0
[   43.763859] [<bf5ac19c>] (cfg80211_event_work [cfg80211]) from [<c003ef5c>] (process_one_work+0x20c/0x4dc)
[   43.766322]  r5:c11e9d20 r4:c5f2c0bc
[   43.766337] [<c003ed50>] (process_one_work) from [<c003f260>] (worker_thread+0x34/0x598)
[   43.766383]  r10:c1024800 r9:00000088 r8:c0ca0720 r7:c1024814 r6:c11e9d38 r5:c1024800
[   43.766398]  r4:c11e9d20
[   43.766409] [<c003f22c>] (worker_thread) from [<c0046ea0>] (kthread+0x144/0x16c)
[   43.766573]  r10:c11f7edc r9:c1223e90 r8:c1226000 r7:c11e9d20 r6:c003f22c r5:c12381a0
[   43.766596]  r4:c11f7ec0 r3:00000000
[   43.766608] [<c0046d5c>] (kthread) from [<c00082f4>] (ret_from_fork+0x14/0x20)
[   43.766645] Exception stack(0xc1227fb0 to 0xc1227ff8)
[   43.766666] 7fa0:                                     00000000 00000000 00000000 00000000
[   43.766687] 7fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[   43.766706] 7fe0: 00000000 00000000 00000000 00000000 00000013 00000000
[   43.766727]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:c0046d5c
[   43.766742]  r4:c12381a0 r3:60000093
[   43.766753] ---[ end trace d168fe495d354789 ]---
[   43.771204] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready

Additional context

No response

kanehekili commented 3 months ago

Same here (Raspi Zero2w):

[Mon Jun 10 04:11:47 2024] WARNING: CPU: 2 PID: 11 at net/wireless/sme.c:1102 __cfg80211_roamed+0x3e0/0x3f8 [cfg80211] [Mon Jun 10 04:11:47 2024] Modules linked in: cmac algif_hash aes_arm64 aes_generic algif_skcipher af_alg bnep vc4 snd_soc_hdmi_codec drm_display_helper cec brcmfmac_wcc drm_dma_helper drm_kms_helper brcmfmac brcmutil snd_soc_core cfg80211 hci_uart btbcm binfmt_misc bluetooth snd_compress raspberrypi_hwmon snd_pcm_dmaengine bcm2835_unicam dw9807_vcm bcm2835_codec(C) v4l2_dv_timings imx708 v4l2_fwnode v4l2_mem2mem bcm2835_isp(C) bcm2835_v4l2(C) v4l2_async bcm2835_mmal_vchiq(C) videobuf2_dma_contig videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 ecdh_generic ecc snd_bcm2835(C) snd_pcm videodev rfkill libaes snd_timer videobuf2_common snd mc vc_sm_cma(C) raspberrypi_gpiomem uio_pdrv_genirq uio drm fuse drm_panel_orientation_quirks dm_mod backlight ip_tables x_tables ipv6 i2c_mux_pinctrl i2c_mux i2c_bcm2835 [Mon Jun 10 04:11:47 2024] CPU: 2 PID: 11 Comm: kworker/u8:0 Tainted: G WC 6.6.31+rpt-rpi-v8 #1 Debian 1:6.6.31-1+rpt1 [Mon Jun 10 04:11:47 2024] Hardware name: Raspberry Pi Zero 2 W Rev 1.0 (DT) [Mon Jun 10 04:11:47 2024] Workqueue: cfg80211 cfg80211_event_work [cfg80211] [Mon Jun 10 04:11:47 2024] pstate: 40000005 (nZcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--) [Mon Jun 10 04:11:47 2024] pc : cfg80211_roamed+0x3e0/0x3f8 [cfg80211] [Mon Jun 10 04:11:47 2024] lr : cfg80211_process_wdev_events+0x160/0x198 [cfg80211] [Mon Jun 10 04:11:47 2024] sp : ffffffc080073cd0 [Mon Jun 10 04:11:47 2024] x29: ffffffc080073cd0 x28: 0000000000000000 x27: 0000000000000000 [Mon Jun 10 04:11:47 2024] x26: ffffff8001d08028 x25: dead000000000100 x24: dead000000000122 [Mon Jun 10 04:11:47 2024] x23: ffffff80053d20c0 x22: ffffff80053d2050 x21: ffffff80053d2008 [Mon Jun 10 04:11:47 2024] x20: ffffff80053d2008 x19: ffffff8001dfa018 x18: 0000000000000000 [Mon Jun 10 04:11:47 2024] x17: 0000000000000000 x16: ffffffdd499020c0 x15: ff1e19ee1a2d002f [Mon Jun 10 04:11:47 2024] x14: 3262005e43420000 x13: 0000000000000000 x12: 0000000000000000 [Mon Jun 10 04:11:47 2024] x11: 00000000000003ce x10: 0000000000001a30 x9 : ffffffdce3e06db0 [Mon Jun 10 04:11:47 2024] x8 : ffffff8001e2d810 x7 : ffffff8001dae740 x6 : 0000000000000018 [Mon Jun 10 04:11:47 2024] x5 : 0000000000000000 x4 : 0000000000000000 x3 : 0000000000000000 [Mon Jun 10 04:11:47 2024] x2 : ffffff8001e2bd80 x1 : ffffff8001dfa018 x0 : 0000000000000000 [Mon Jun 10 04:11:47 2024] Call trace: [Mon Jun 10 04:11:47 2024] cfg80211_roamed+0x3e0/0x3f8 [cfg80211] [Mon Jun 10 04:11:47 2024] cfg80211_process_wdev_events+0x160/0x198 [cfg80211] [Mon Jun 10 04:11:47 2024] cfg80211_process_rdev_events+0x38/0x60 [cfg80211] [Mon Jun 10 04:11:47 2024] cfg80211_event_work+0x30/0x50 [cfg80211] [Mon Jun 10 04:11:47 2024] process_one_work+0x148/0x3b8 [Mon Jun 10 04:11:47 2024] worker_thread+0x32c/0x450 [Mon Jun 10 04:11:47 2024] kthread+0x11c/0x128 [Mon Jun 10 04:11:47 2024] ret_from_fork+0x10/0x20 [Mon Jun 10 04:11:47 2024] ---[ end trace 0000000000000000 ]---