Verdin iMX8MP WiFi driver timeout

We have issues where the WiFi modules stop responding to the driver.

We’ve had this issue in the past but it seems to be less frequent after switching to the proprietary driver (for WPA3 support), but it seems to be back again.

I’m not in a position to try this with a reference image on a reference carrier board at the moment, but I’m hoping someone might have suggestions anyways. It might be related to background scanning, or it might be totally unrelated. We’ve seen this with both the driver included with the kernel, and the proprietary driver, with the firmware you normally get with the Yocto build, and the firmware included with the prop driver.

We have a custom carrier board, and have observed this on both Verdin iMX8MP Q 4GB WB IT V1.1A and V1.1B. We run a custom Yocto image

Linux verdin-imx8mp 5.15.129-6.4.0-devel+git.67c3153d20ff #1 SMP PREEMPT Wed Sep 27 12:30:36 UTC 2023 aarch64 aarch64 aarch64 GNU/Linux

Only the WiFi crash (we’re not running BT, so I’m not sure about the BT stack) Linux itself and other drivers (like inserting a USB-C to Ethernet) still work.

mlan0 (uap0 and wfd0 also) disappear after the driver crash (as expected). Trying to unload and reload the driver doesn’t fix the issue either. Log of that is also included below.

Rebooting fixes the issue.

We’re running the following layer versions

meta-arm                       b187fb9232ca0a6b5f8f90b4715958546fc41d73
meta-clang                     79169d9be565b7a87310ca280d3a21aaf608ce33
meta-flutter                   a130deb48a7ccaa8e4a082ad14572490d69d8f41
meta-freescale                 3e9ef23d98aa842cf84251a27c9b8dde8925ea61
meta-freescale-3rdparty        1a6ea560015ecda5fff8eccaf5b1327f1bb6c57f
meta-freescale-distro          d5bbb487b2816dfc74984a78b67f7361ce404253
meta-openembedded              a88cb922f91fda95e8a584cee3092083d5ad3e98
meta-tem                       21c89d8aef896e9aae4c4edc38c19ac30ed0c1fd
meta-toradex-bsp-common        e4fa05527dcecbddd6aa1b2bc7deebbf53c6bd83
meta-toradex-demos             655ddc7a45b883d705407b6a002aac8191b58c7d
meta-toradex-distro            9480d591b81316ce0e828f37bed74329de2a5d81
meta-toradex-nxp               0dd8d488b694212cf02357c4651183938994e484
meta-yocto                     8b50fe692a24a80b5c3cd1f816bcdd3e0b00418a
openembedded-core              6c7fef37d4286f6bfc7b1dcb2d1e543a110a7f6f
openembedded-core/bitbake      41b6684489d0261753344956042be2cc4adb0159

Here’s the output from dmesg around the error, including the last messages before the crash.

[28028.004034] wlan: mlan0 START SCAN
[28033.064601] wlan: SCAN COMPLETED: scanned AP count=61
[28034.651319] wlan: mlan0 START SCAN
[28039.822750] wlan: SCAN COMPLETED: scanned AP count=61
[28043.003692] wlan: mlan0 START SCAN
[28048.117389] wlan: SCAN COMPLETED: scanned AP count=61
[28049.678928] wlan: mlan0 START SCAN
[28054.773530] wlan: SCAN COMPLETED: scanned AP count=61
[28058.006570] wlan: mlan0 START SCAN
[28063.067826] wlan: SCAN COMPLETED: scanned AP count=60
[28064.706885] wlan: mlan0 START SCAN
[28085.212202] Ext scan enh timeout
[28085.212226] ------------Dump info-----------
[28085.212233] EXT_SCAN_STATUS event Timeout
[28085.212239] CurCmd Empty
[28085.212245] mlan_processing =0
[28085.212253] main_lock_flag =0
[28085.212259] main_process_cnt =167954
[28085.212266] delay_task_flag =0
[28085.212271] mlan_rx_processing =0
[28085.212276] rx_pkts_queued=0
[28085.212282] more_task_flag = 0
[28085.212287] num_cmd_timeout = 0
[28085.212293] last_cmd_index = 1
[28085.212298] last_cmd_id =
[28085.212303] 0x107
[28085.212308] 0x107
[28085.212313] 0x107
[28085.212318] 0x107
[28085.212323] 0x107
[28085.212329] 0x107
[28085.212334] 0x107
[28085.212339] 0x107
[28085.212344] 0x107
[28085.212349] 0x107

[28085.212359] last_cmd_act =
[28085.212363] 0x1
[28085.212368] 0x1
[28085.212373] 0x1
[28085.212378] 0x1
[28085.212383] 0x1
[28085.212388] 0x1
[28085.212393] 0x1
[28085.212398] 0x1
[28085.212403] 0x1
[28085.212408] 0x1

[28085.212418] last_cmd_resp_index = 1
[28085.212423] last_cmd_resp_id =
[28085.212428] 0x8107
[28085.212433] 0x8107
[28085.212438] 0x8107
[28085.212443] 0x8107
[28085.212448] 0x8107
[28085.212453] 0x8107
[28085.212458] 0x8107
[28085.212463] 0x8107
[28085.212468] 0x8107
[28085.212473] 0x8107

[28085.212484] last_event_index = 3
[28085.212489] last_event =
[28085.212493] 0x58
[28085.212498] 0x58
[28085.212503] 0x58
[28085.212508] 0x58
[28085.212513] 0x58
[28085.212518] 0x58
[28085.212524] 0x58
[28085.212529] 0x58
[28085.212533] 0x58
[28085.212538] 0x58

[28085.212548] num_data_h2c_failure = 0
[28085.212553] num_cmd_h2c_failure = 0
[28085.212559] num_data_c2h_failure = 0
[28085.212565] num_cmdevt_c2h_failure = 0
[28085.212570] num_int_read_failure = 0
[28085.212575] last_int_status = 64
[28085.212580] num_alloc_buffer_failure = 0
[28085.212586] num_pkt_dropped = 0
[28085.212592] num_no_cmd_node = 0
[28085.212597] num_event_deauth = 0
[28085.212602] num_event_disassoc = 0
[28085.212608] num_event_link_lost = 0
[28085.212613] num_cmd_deauth = 1
[28085.212619] num_cmd_assoc_success = 1
[28085.212624] num_cmd_assoc_failure = 0
[28085.212629] num_cons_assoc_failure = 0
[28085.212635] cmd_resp_received=0
[28085.212640] event_received=0
[28085.212645] max_tx_buf_size=4096
[28085.212650] tx_buf_size=0
[28085.212656] curr_tx_buf_size=3072
[28085.212663] data_sent=0 cmd_sent=0
[28085.212669] ps_mode=0 ps_state=0
[28085.212675] wakeup_dev_req=0 wakeup_tries=0 wakeup_timeout=0
[28085.212683] hs_configured=0 hs_activated=0
[28085.212688] pps_uapsd_mode=0 sleep_pd=0
[28085.212694] tx_lock_flag = 0
[28085.212702] scan_processing = 1
[28085.212707] scan_state = 0x85
[28085.212713] bypass_pkt_count=0
[28085.212721] mp_rd_bitmap=0x0 curr_rd_port=0x1a
[28085.212727] mp_wr_bitmap=0xffe00000 curr_wr_port=0x15
[28085.212733] mp_data_port_mask = 0xffffffff
[28085.212739] last_recv_rd_bitmap=0x2000000 mp_invalid_update=1
[28085.212745] last_recv_wr_bitmap=0xffffffff last_mp_index=1
[28085.212752] mp_wr_bitmap: 0xffe00000 mp_wr_ports=0x10014 len=256 curr_wr_port=0x15
[28085.212760] 0xfb
[28085.212765] 0x00
[28085.212770] 0x00
[28085.212775] 0x00
[28085.212780] 0x00
[28085.212785] 0x00
[28085.212790] 0x00
[28085.212796] 0x00
[28085.212801] 0x00
[28085.212806] 0x00
[28085.212811] 0x00
[28085.212816] 0x00
[28085.212821] 0x00
[28085.212826] 0x00
[28085.212831] 0x00
[28085.212837] 0x00

[28085.212847] mp_wr_bitmap: 0xfffff000 mp_wr_ports=0x1000b len=512 curr_wr_port=0xc
[28085.212855] 0x105
[28085.212859] 0x00
[28085.212865] 0x00
[28085.212872] 0x00
[28085.212877] 0x00
[28085.212882] 0x00
[28085.212888] 0x00
[28085.212893] 0x00
[28085.212898] 0x00
[28085.212903] 0x00
[28085.212910] 0x00
[28085.212916] 0x00
[28085.212920] 0x00
[28085.212927] 0x00
[28085.212932] 0x00
[28085.212937] 0x00

[28085.212948] mp_wr_bitmap: 0xffffe000 mp_wr_ports=0x1000c len=256 curr_wr_port=0xd
[28085.212956] 0x7c
[28085.212963] 0x00
[28085.212968] 0x00
[28085.212973] 0x00
[28085.212978] 0x00
[28085.212985] 0x00
[28085.212990] 0x00
[28085.212995] 0x00
[28085.213002] 0x00
[28085.213007] 0x00
[28085.213012] 0x00
[28085.213020] 0x00
[28085.213025] 0x00
[28085.213030] 0x00
[28085.213035] 0x00
[28085.213041] 0x00

[28085.213050] mp_wr_bitmap: 0xffffc000 mp_wr_ports=0x1000d len=256 curr_wr_port=0xe
[28085.213060] 0x90
[28085.213065] 0x00
[28085.213070] 0x00
[28085.213075] 0x00
[28085.213080] 0x00
[28085.213085] 0x00
[28085.213090] 0x00
[28085.213095] 0x00
[28085.213100] 0x00
[28085.213105] 0x00
[28085.213110] 0x00
[28085.213116] 0x00
[28085.213121] 0x00
[28085.213126] 0x00
[28085.213131] 0x00
[28085.213136] 0x00

[28085.213146] mp_wr_bitmap: 0xffff8000 mp_wr_ports=0x1000e len=512 curr_wr_port=0xf
[28085.213154] 0x107
[28085.213159] 0x00
[28085.213164] 0x00
[28085.213171] 0x00
[28085.213176] 0x00
[28085.213181] 0x00
[28085.213188] 0x00
[28085.213193] 0x00
[28085.213198] 0x00
[28085.213203] 0x00
[28085.213208] 0x00
[28085.213213] 0x00
[28085.213218] 0x00
[28085.213224] 0x00
[28085.213229] 0x00
[28085.213234] 0x00

[28085.213246] mp_wr_bitmap: 0xffff0000 mp_wr_ports=0x1000f len=512 curr_wr_port=0x10
[28085.213254] 0x107
[28085.213258] 0x00
[28085.213265] 0x00
[28085.213270] 0x00
[28085.213275] 0x00
[28085.213281] 0x00
[28085.213286] 0x00
[28085.213291] 0x00
[28085.213296] 0x00
[28085.213302] 0x00
[28085.213307] 0x00
[28085.213312] 0x00
[28085.213319] 0x00
[28085.213324] 0x00
[28085.213329] 0x00
[28085.213336] 0x00

[28085.213345] mp_wr_bitmap: 0xfffe0000 mp_wr_ports=0x10010 len=512 curr_wr_port=0x11
[28085.213353] 0x107
[28085.213358] 0x00
[28085.213363] 0x00
[28085.213368] 0x00
[28085.213376] 0x00
[28085.213381] 0x00
[28085.213386] 0x00
[28085.213393] 0x00
[28085.213398] 0x00
[28085.213403] 0x00
[28085.213408] 0x00
[28085.213413] 0x00
[28085.213418] 0x00
[28085.213423] 0x00
[28085.213428] 0x00
[28085.213433] 0x00

[28085.213442] mp_wr_bitmap: 0xfffc0000 mp_wr_ports=0x10011 len=256 curr_wr_port=0x12
[28085.213450] 0xfb
[28085.213455] 0x00
[28085.213460] 0x00
[28085.213465] 0x00
[28085.213471] 0x00
[28085.213476] 0x00
[28085.213481] 0x00
[28085.213486] 0x00
[28085.213491] 0x00
[28085.213496] 0x00
[28085.213501] 0x00
[28085.213506] 0x00
[28085.213512] 0x00
[28085.213517] 0x00
[28085.213524] 0x00
[28085.213529] 0x00

[28085.213538] mp_wr_bitmap: 0xfff80000 mp_wr_ports=0x10012 len=256 curr_wr_port=0x13
[28085.213546] 0xfb
[28085.213551] 0x00
[28085.213556] 0x00
[28085.213563] 0x00
[28085.213568] 0x00
[28085.213573] 0x00
[28085.213581] 0x00
[28085.213586] 0x00
[28085.213590] 0x00
[28085.213598] 0x00
[28085.213603] 0x00
[28085.213607] 0x00
[28085.213613] 0x00
[28085.213618] 0x00
[28085.213623] 0x00
[28085.213628] 0x00

[28085.213640] mp_wr_bitmap: 0xfff00000 mp_wr_ports=0x10013 len=256 curr_wr_port=0x14
[28085.213648] 0x68
[28085.213652] 0x00
[28085.213658] 0x00
[28085.213663] 0x00
[28085.213667] 0x00
[28085.213674] 0x00
[28085.213679] 0x00
[28085.213684] 0x00
[28085.213690] 0x00
[28085.213695] 0x00
[28085.213700] 0x00
[28085.213705] 0x00
[28085.213710] 0x00
[28085.213715] 0x00
[28085.213721] 0x00
[28085.213727] 0x00

[28085.213737] bss_index = 0, tx_pkts_queued = 0 tx_pause
[28085.213747] bss_index = 1, tx_pkts_queued = 0 tx_pause
[28085.213754] bss_index = 2, tx_pkts_queued = 0 tx_pause
[28085.213762] bss_index = 3, tx_pkts_queued = 0 tx_pause
[28085.213775] Driver version = SD8997----16.92.21.p84.4-MM6X16437.p3-GPL-(FP92)
[28085.221029] main_state = 4
[28085.223739] ioctl_pending = 1
[28085.226707] tx_pending = 0
[28085.229435] wmm_tx_pending[0] = 0
[28085.232758] wmm_tx_pending[1] = 0
[28085.236084] wmm_tx_pending[2] = 0
[28085.239402] wmm_tx_pending[3] = 0
[28085.242760] rx_pending = 0
[28085.245474] lock_count = 81
[28085.248269] malloc_count = 54
[28085.251237] mbufalloc_count = 0
[28085.254386] hs_skip_count = 0
[28085.257353] hs_force_count = 0
[28085.260407] Media state = "Disconnected"
[28085.264345] carrier off
[28085.266807] tx queue 0: stopped
[28085.269954] tx queue 1: stopped
[28085.273096] tx queue 2: stopped
[28085.276248] tx queue 3: stopped
[28085.279393] mlan0: num_tx_timeout = 0
[28085.283075] uap0: num_tx_timeout = 0
[28085.286653] wfd0: num_tx_timeout = 0
[28085.290239] Start to process hanging
[28085.293830] -------- Dump info End---------
[28085.293841] FW in debug mode (0x5a)
[28085.293978] Cancel all pending cmd and txrx queue
[28085.297353] IOCTL failed: 0000000046cc56a3 id=0x10000, sub_id=0x10003 action=1, status_code=0x80000007
[28085.297512] SDIO Func0 (0x0-0x9): 43 03 02 02 03 00 00 02 03 00
[28085.312835] SDIO Func1 (0x10-0x17): 00 00 00 00 00 00 e0 ff
[28085.319281] SDIO Func1: (0x8) c3 (0x58) 00 (0x5c) 08 (0x5d) 00 (0x60) 07 (0x61) 0c (0x62) 00 (0x64) 10 (0x65) 00 (0x66) 00 (0x68) 00 (0x69) 00 (0x6a) 00
[28085.333588] SDIO Func1 (0xe8-0xff): dc fe ca 5a c7 02 00 61 24 14 70 c8 40 03 80 00 00 00 00 00 00 00 00 00
[28085.445712] SDIO Func1 (0xe8-0xff): dc fe ca 5a c7 02 00 61 24 14 70 c8 40 03 80 00 00 00 00 00 00 00 00 00
[28085.455610] WIFI auto_fw_reload: fw_reload=1
[28085.459921] ========START IN-BAND RESET===========
[28085.464794] woal_reset_intf: get bss info failed
[28085.469537] Cancel all pending cmd and txrx queue
[28085.920633] FW wake up
[28085.924117] SDIO Trigger FW In-band Reset success
[28085.924138] SDIO: max_segs=128 max_seg_size=65535
[28085.933645] rx_work=1 cpu_num=4
[28085.936822] Enable moal_recv_amsdu_packet
[28085.936855] Attach mlan adapter operations.card_type is 0x104.
[28085.937183] wlan: Enable TX SG mode
[28085.937192] wlan: Enable RX SG mode
[28085.937202] Request firmware: nxp/sdiouart8997_combo_v4.bin
[28086.245212] wlan_sdio_poll_card_status failed, tries = 10000, cs = 0xc
[28086.245230] WLAN: FW download with helper poll status timeout @ 16
[28086.245235] wlan_dnld_fw fail ret=0xffffffff
[28086.245239] wlan_dnld_fw fail ret=0xffffffff
[28086.245242] WLAN: Fail download FW with nowwait: 0
[28086.250279] SDIO Func0 (0x0-0x9): 43 03 02 02 03 00 00 02 03 00
[28086.256486] SDIO Func1 (0x10-0x17): 00 00 00 00 00 00 00 00
[28086.262376] SDIO Func1: (0x8) 00 (0x58) 00 (0x5c) 0c (0x5d) 00 (0x60) 01 (0x61) 00 (0x62) 00 (0x64) 11 (0x65) 00 (0x66) 00 (0x68) 00 (0x69) 00 (0x6a) 00
[28086.276548] SDIO Func1 (0xe8-0xff): 00 00 00 00 00 00 00 61 24 14 70 c8 40 03 80 00 10 00 00 00 00 00 00 00
[28086.388665] SDIO Func1 (0xe8-0xff): 00 00 00 00 00 00 00 61 24 14 70 c8 40 03 80 00 10 00 00 00 00 00 00 00
[28086.398561] woal_request_fw failed
[28086.401984] Firmware Init Failed
[28086.405386] SDIO Func0 (0x0-0x9): 43 03 02 02 03 00 00 02 03 00
[28086.411521] SDIO Func1 (0x10-0x17): 00 00 00 00 00 00 00 00
[28086.417362] SDIO Func1: (0x8) 00 (0x58) 00 (0x5c) 0c (0x5d) 00 (0x60) 01 (0x61) 00 (0x62) 00 (0x64) 11 (0x65) 00 (0x66) 00 (0x68) 00 (0x69) 00 (0x6a) 00
[28086.431430] SDIO Func1 (0xe8-0xff): 00 00 00 00 00 00 00 61 24 14 70 c8 40 03 80 00 10 00 00 00 00 00 00 00
[28086.543580] SDIO Func1 (0xe8-0xff): 00 00 00 00 00 00 00 61 24 14 70 c8 40 03 80 00 10 00 00 00 00 00 00 00
[28086.640283] Free module params
[28086.643357] ========END IN-BAND RESET===========

Here’s the dmesg around reloading the driver

[146877.293210] audit: type=1327 audit(1729757467.020:70): proctitle=737368643A20726F6F74205B707269765D
[154897.716563] audit: type=1006 audit(1729765487.303:71): pid=45684 uid=0 old-auid=4294967295 auid=0 tty=(none) old-ses=4294967295 ses=4 res=1
[154897.716587] audit: type=1300 audit(1729765487.303:71): arch=c00000b7 syscall=64 success=yes exit=1 a0=7 a1=ffffcb7edf60 a2=1 a3=ffffa6162b20 items=0 ppid=1 pid=45684 auid=0 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4 comm="sshd" exe="/usr/sbin/sshd" key=(null)
[154897.716597] audit: type=1327 audit(1729765487.303:71): proctitle=737368643A20726F6F74205B707269765D
[154919.750547] wlan: Unloading MWLAN driver
[154919.754826] wlan: Driver unloaded
[154939.787381] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[154939.795510] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[154939.813163] wlan: Loading MWLAN driver
[154939.817416] wlan: Register to Bus Driver...
[154939.822101] vendor=0x02DF device=0x9141 class=0 function=1
[154939.827889] Attach moal handle ops, card interface type: 0x104
[154939.834009] rps set to 0 from module param
[154939.838451] SD8997: init module param from usr cfg
[154939.843487] card_type: SD8997, config block: 0
[154939.848103] cfg80211_wext=0xf
[154939.851166] max_vir_bss=1
[154939.853931] cal_data_cfg=none
[154939.857031] ps_mode = 1
[154939.859586] auto_ds = 1
[154939.862124] host_mlme=enable
[154939.865110] fw_name=nxp/sdiouart8997_combo_v4.bin
[154939.869960] SDIO: max_segs=128 max_seg_size=65535
[154939.874786] rx_work=1 cpu_num=4
[154939.878035] Enable moal_recv_amsdu_packet
[154939.878060] Attach mlan adapter operations.card_type is 0x104.
[154939.878448] wlan: Enable TX SG mode
[154939.878459] wlan: Enable RX SG mode
[154939.883513] Request firmware: nxp/sdiouart8997_combo_v4.bin
[154940.225223] wlan_sdio_poll_card_status failed, tries = 10000, cs = 0xc
[154940.225240] WLAN: FW download with helper poll status timeout @ 0
[154940.225245] wlan_dnld_fw fail ret=0xffffffff
[154940.225248] wlan_dnld_fw fail ret=0xffffffff
[154940.225252] WLAN: Fail download FW with nowwait: 0
[154940.230546] SDIO Func0 (0x0-0x9): 43 03 02 02 03 00 08 02 03 00
[154940.237436] SDIO Func1 (0x10-0x17): 00 00 00 00 00 00 00 00
[154940.243458] SDIO Func1: (0x8) 00 (0x58) 00 (0x5c) 0c (0x5d) 00 (0x60) 01 (0x61) 00 (0x62) 00 (0x64) 11 (0x65) 03 (0x66) 00 (0x68) 00 (0x69) 00 (0x6a) 00
[154940.257626] SDIO Func1 (0xe8-0xff): 00 00 00 00 00 00 00 61 24 14 70 c8 40 03 80 00 10 00 00 00 00 00 00 00
[154940.369896] SDIO Func1 (0xe8-0xff): 00 00 00 00 00 00 00 61 24 14 70 c8 40 03 80 00 10 00 00 00 00 00 00 00
[154940.379884] woal_request_fw failed
[154940.383378] Firmware Init Failed
[154940.387204] Free module params
[154940.390407] woal_add_card failed
[154940.393806] wlan_sdio: probe of mmc0:0001:1 failed with error -1
[154940.393901] wlan: Register to Bus Driver Done
[154940.398397] wlan: Driver loaded successfully

dmesg will be included in a comment (32k characted limit)

And the dmesg (from another boot because dmesg buffer was overwritten with SCAN messages when I logged in over Ethernet today)

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 5.15.129-6.4.0-devel+git.67c3153d20ff (oe-user@oe-host) (aarch64-tdx-linux-gcc (GCC) 11.4.0, GNU ld (GNU Binutils) 2.38.20220708) #1 SMP PREEMPT Wed Sep 27 12:30:36 UTC 2023
[    0.000000] Machine model: Toradex Verdin iMX8M Plus WB on TEM Board
[    0.000000] earlycon: ec_imx6q0 at MMIO 0x0000000030880000 (options '')
[    0.000000] printk: bootconsole [ec_imx6q0] enabled
[    0.000000] Reserved memory: created CMA memory pool at 0x00000000dc000000, size 512 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] NUMA: No NUMA configuration found
[    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]
[    0.000000] NUMA: NODE_DATA [mem 0x13f798800-0x13f79afff]
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000040000000-0x00000000ffffffff]
[    0.000000]   DMA32    empty
[    0.000000]   Normal   [mem 0x0000000100000000-0x000000013fffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000040000000-0x000000013fffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: MIGRATE_INFO_TYPE not supported.
[    0.000000] psci: SMC Calling Convention v1.2
[    0.000000] percpu: Embedded 18 pages/cpu s35864 r8192 d29672 u73728
[    0.000000] pcpu-alloc: s35864 r8192 d29672 u73728 alloc=18*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: detected: GIC system register CPU interface
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1032192
[    0.000000] Policy zone: Normal
[    0.000000] Kernel command line: root=/dev/mmcblk2p1 rootflags=subvol=root/1.8.1.0 rootfstype=btrfs ro consoleblank=0 vt.global_cursor_default=0 console=ttymxc2,115200 quiet earlycon systemd.gpt_auto=no
[    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: mapped [mem 0x00000000d8000000-0x00000000dc000000] (64MB)
[    0.000000] Memory: 3498920K/4194304K available (13440K kernel code, 1510K rwdata, 5472K rodata, 3072K init, 475K bss, 171096K reserved, 524288K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU event tracing is enabled.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
[    0.000000]  Trampoline variant of Tasks RCU enabled.
[    0.000000]  Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: 160 SPIs implemented
[    0.000000] GICv3: 0 Extended SPIs implemented
[    0.000000] GICv3: Distributor has no Range Selector support
[    0.000000] Root IRQ handler: gic_handle_irq
[    0.000000] GICv3: 16 PPIs implemented
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000038880000
[    0.000000] ITS: No ITS available, not enabling LPIs
[    0.000000] arch_timer: cp15 timer(s) running at 8.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1d854df40, max_idle_ns: 440795202120 ns
[    0.000000] sched_clock: 56 bits at 8MHz, resolution 125ns, wraps every 2199023255500ns
[    0.000499] Console: colour dummy device 80x25
[    0.000563] Calibrating delay loop (skipped), value calculated using timer frequency.. 16.00 BogoMIPS (lpj=32000)
[    0.000574] pid_max: default: 32768 minimum: 301
[    0.000634] LSM: Security Framework initializing
[    0.000716] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.000736] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.002149] rcu: Hierarchical SRCU implementation.
[    0.003095] smp: Bringing up secondary CPUs ...
[    0.003528] Detected VIPT I-cache on CPU1
[    0.003554] GICv3: CPU1: found redistributor 1 region 0:0x00000000388a0000
[    0.003589] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.004070] Detected VIPT I-cache on CPU2
[    0.004088] GICv3: CPU2: found redistributor 2 region 0:0x00000000388c0000
[    0.004108] CPU2: Booted secondary processor 0x0000000002 [0x410fd034]
[    0.004522] Detected VIPT I-cache on CPU3
[    0.004541] GICv3: CPU3: found redistributor 3 region 0:0x00000000388e0000
[    0.004563] CPU3: Booted secondary processor 0x0000000003 [0x410fd034]
[    0.004620] smp: Brought up 1 node, 4 CPUs
[    0.004630] SMP: Total of 4 processors activated.
[    0.004634] CPU features: detected: 32-bit EL0 Support
[    0.004638] CPU features: detected: CRC32 instructions
[    0.010299] CPU: All CPU(s) started at EL2
[    0.010318] alternatives: patching kernel code
[    0.011568] devtmpfs: initialized
[    0.021135] KASLR disabled due to lack of seed
[    0.021267] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.021282] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.034820] pinctrl core: initialized pinctrl subsystem
[    0.035678] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.040537] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
[    0.040938] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.041354] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.041440] audit: initializing netlink subsys (disabled)
[    0.041638] audit: type=2000 audit(0.040:1): state=initialized audit_enabled=0 res=1
[    0.042062] thermal_sys: Registered thermal governor 'step_wise'
[    0.042067] thermal_sys: Registered thermal governor 'power_allocator'
[    0.042453] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.042532] ASID allocator initialised with 65536 entries
[    0.042772] Serial: AMBA PL011 UART driver
[    0.042829] imx mu driver is registered.
[    0.042845] imx rpmsg driver is registered.
[    0.053069] imx8mp-pinctrl 30330000.pinctrl: initialized IMX pinctrl driver
[    0.062794] platform 32c00000.bus:ldb@32ec005c: Fixing up cyclic dependency with 32e90000.lcd-controller
[    0.069623] platform panel-lvds-mez: Fixing up cyclic dependency with 32c00000.bus:ldb@32ec005c
[    0.078809] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.078822] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
[    0.078828] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.078833] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
[    0.080299] cryptd: max_cpu_qlen set to 1000
[    0.082635] raid6: skip pq benchmark and using algorithm neonx8
[    0.082647] raid6: using neon recovery algorithm
[    0.084392] iommu: Default domain type: Translated
[    0.084400] iommu: DMA domain TLB invalidation policy: strict mode
[    0.084692] SCSI subsystem initialized
[    0.084802] libata version 3.00 loaded.
[    0.084972] usbcore: registered new interface driver usbfs
[    0.085001] usbcore: registered new interface driver hub
[    0.085029] usbcore: registered new device driver usb
[    0.086041] EDAC MC: Ver: 3.0.0
[    0.086771] FPGA manager framework
[    0.086849] Advanced Linux Sound Architecture Driver Initialized.
[    0.087778] clocksource: Switched to clocksource arch_sys_counter
[    0.087908] VFS: Disk quotas dquot_6.6.0
[    0.087951] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.093786] NET: Registered PF_INET protocol family
[    0.093944] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    0.095507] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[    0.095577] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.095591] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.095822] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[    0.096250] TCP: Hash tables configured (established 32768 bind 32768)
[    0.096343] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    0.096422] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    0.096600] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.097258] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available
[    0.100981] Initialise system trusted keyrings
[    0.101122] workingset: timestamp_bits=42 max_order=20 bucket_order=0
[    0.142582] xor: automatically using best checksumming function   32regs
[    0.142598] Key type asymmetric registered
[    0.142602] Asymmetric key parser 'x509' registered
[    0.142651] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    0.142658] io scheduler mq-deadline registered
[    0.142662] io scheduler kyber registered
[    0.154772] mxs-dma 33000000.dma-apbh: initialized
[    0.155866] SoC: i.MX8MP revision 1.1
[    0.156380] Bus freq driver module loaded
[    0.162177] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.164214] 30860000.serial: ttymxc0 at MMIO 0x30860000 (irq = 35, base_baud = 1500000) is a IMX
[    0.164653] 30880000.serial: ttymxc2 at MMIO 0x30880000 (irq = 36, base_baud = 1500000) is a IMX
[    0.164696] printk: console [ttymxc2] enabled
[    0.164704] printk: bootconsole [ec_imx6q0] disabled
[    0.165139] 30890000.serial: ttymxc1 at MMIO 0x30890000 (irq = 37, base_baud = 1500000) is a IMX
[    0.165580] 30a60000.serial: ttymxc3 at MMIO 0x30a60000 (irq = 42, base_baud = 1500000) is a IMX
[    0.165682] serial serial0: tty port ttymxc3 registered
[    0.180581] brd: module loaded
[    0.184633] loop: module loaded
[    0.191027] tun: Universal TUN/TAP device driver, 1.6
[    0.192111] usbcore: registered new interface driver r8152
[    0.192235] VFIO - User Level meta-driver version: 0.3
[    0.195857] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.195885] ehci-platform: EHCI generic platform driver
[    0.196077] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    0.196091] ohci-platform: OHCI generic platform driver
[    0.196782] usbcore: registered new interface driver uas
[    0.196825] usbcore: registered new interface driver usb-storage
[    0.196878] usbcore: registered new interface driver usbserial_generic
[    0.196898] usbserial: USB Serial support registered for generic
[    0.196918] usbcore: registered new interface driver ftdi_sio
[    0.196935] usbserial: USB Serial support registered for FTDI USB Serial Device
[    0.196962] usbcore: registered new interface driver usb_serial_simple
[    0.196980] usbserial: USB Serial support registered for carelink
[    0.196995] usbserial: USB Serial support registered for flashloader
[    0.197013] usbserial: USB Serial support registered for funsoft
[    0.197029] usbserial: USB Serial support registered for google
[    0.197045] usbserial: USB Serial support registered for hp4x
[    0.197061] usbserial: USB Serial support registered for kaufmann
[    0.197080] usbserial: USB Serial support registered for libtransistor
[    0.197095] usbserial: USB Serial support registered for moto_modem
[    0.197111] usbserial: USB Serial support registered for motorola_tetra
[    0.197132] usbserial: USB Serial support registered for nokia
[    0.197149] usbserial: USB Serial support registered for novatel_gps
[    0.197167] usbserial: USB Serial support registered for siemens_mpi
[    0.197181] usbserial: USB Serial support registered for suunto
[    0.197201] usbserial: USB Serial support registered for vivopay
[    0.197215] usbserial: USB Serial support registered for zio
[    0.197242] usbcore: registered new interface driver usb_ehset_test
[    0.200617] snvs_rtc 30370000.snvs:snvs-rtc-lp: registered as rtc1
[    0.200758] i2c_dev: i2c /dev entries driver
[    0.204354] EDAC MC: ECC not enabled
[    0.204941] sdhci: Secure Digital Host Controller Interface driver
[    0.204946] sdhci: Copyright(c) Pierre Ossman
[    0.205544] Synopsys Designware Multimedia Card Interface Driver
[    0.206171] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.208297] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
[    0.208646] usbcore: registered new interface driver usbhid
[    0.208651] usbhid: USB HID core driver
[    0.211688]  cs_system_cfg: CoreSight Configuration manager initialised
[    0.213981] hantrodec 0 : module inserted. Major = 239
[    0.214414] hantrodec 1 : module inserted. Major = 239
[    0.215071] hantroenc: HW at base <0000000038320000> with ID <0x80006200>
[    0.215186] hx280enc: module inserted. Major <238>
[    0.216596] NET: Registered PF_LLC protocol family
[    0.217089] NET: Registered PF_INET6 protocol family
[    0.217751] Segment Routing with IPv6
[    0.217786] In-situ OAM (IOAM) with IPv6
[    0.217826] NET: Registered PF_PACKET protocol family
[    0.217931] 8021q: 802.1Q VLAN Support v1.8
[    0.218100] Loading compiled-in X.509 certificates
[    0.219106] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
[    0.235346] gpio-125 (CTRL_SLEEP_MOCI#): hogged as output/high
[    0.235824] mmc2: SDHCI controller on 30b60000.mmc [30b60000.mmc] using ADMA
[    0.237886] +V3.3_SD: supplied by +V3.3_SW
[    0.248163] nxp-pca9450 0-0025: pca9450bc probed.
[    0.250207] rtc-ds1307 0-0032: registered as rtc0
[    0.251032] rtc-ds1307 0-0032: setting system clock to 2024-10-24T10:30:36 UTC (1729765836)
[    0.253193] at24 0-0050: supply vcc not found, using dummy regulator
[    0.253672] at24 0-0050: 256 byte 24c02 EEPROM, writable, 16 bytes/write
[    0.253720] i2c i2c-0: IMX I2C adapter registered
[    0.254358] i2c i2c-2: IMX I2C adapter registered
[    0.255906] input: fts_ts as /devices/platform/soc@0/30800000.bus/30a50000.i2c/i2c-3/3-0038/input/input0
[    0.293324] mmc2: new HS400 Enhanced strobe MMC card at address 0001
[    0.293771] mmcblk2: mmc2:0001 IX2932 29.1 GiB
[    0.296361]  mmcblk2: p1
[    0.296795] mmcblk2boot0: mmc2:0001 IX2932 4.00 MiB
[    0.297689] mmcblk2boot1: mmc2:0001 IX2932 4.00 MiB
[    0.298475] mmcblk2rpmb: mmc2:0001 IX2932 4.00 MiB, chardev (241:0)
[    0.492680] i2c i2c-3: IMX I2C adapter registered
[    0.493525] imx8mq-usb-phy 381f0040.usb-phy: supply vbus not found, using dummy regulator
[    0.494693] pwm-backlight backlight-mezzanine: supply power not found, using dummy regulator
[    0.509355] imx-drm display-subsystem: bound imx-lcdifv3-crtc.0 (ops lcdifv3_crtc_ops)
[    0.511937] clk: failed to reparent hsio_axi to sys_pll2_500m: -16
[    0.520615] imx-cpufreq-dt imx-cpufreq-dt: cpu speed grade 7 mkt segment 2 supported-hw 0x80 0x4
[    0.523382] sdhci-esdhc-imx 30b50000.mmc: Got CD GPIO
[    0.523495] On-module +V3.3_ETH: supplied by On-module +V3.3 (BUCK4)
[    0.556051] mmc0: SDHCI controller on 30b40000.mmc [30b40000.mmc] using ADMA
[    0.556184] mmc1: SDHCI controller on 30b50000.mmc [30b50000.mmc] using ADMA
[    0.608062] mmc0: new ultra high speed SDR104 SDIO card at address 0001
[    0.729277] imx-drm display-subsystem: bound imx-lcdifv3-crtc.0 (ops lcdifv3_crtc_ops)
[    0.729472] imx-drm display-subsystem: bound 32c00000.bus:ldb@32ec005c (ops imx8mp_ldb_ops)
[    0.729729] [drm] Initialized imx-drm 1.0.0 20120507 for display-subsystem on minor 0
[    0.761433] Console: switching to colour frame buffer device 128x37
[    0.776185] imx-drm display-subsystem: [drm] fb0: imx-drmdrmfb frame buffer device
[    0.777862] imx-dwmac 30bf0000.ethernet: IRQ eth_lpi not found
[    0.778217] imx-dwmac 30bf0000.ethernet: User ID: 0x10, Synopsys ID: 0x51
[    0.778228] imx-dwmac 30bf0000.ethernet:     DWMAC4/5
[    0.778235] imx-dwmac 30bf0000.ethernet: DMA HW capability register supported
[    0.778240] imx-dwmac 30bf0000.ethernet: RX Checksum Offload Engine supported
[    0.778245] imx-dwmac 30bf0000.ethernet: Wake-Up On Lan supported
[    0.778297] imx-dwmac 30bf0000.ethernet: Enable RX Mitigation via HW Watchdog Timer
[    0.778304] imx-dwmac 30bf0000.ethernet: Enabled L3L4 Flow TC (entries=8)
[    0.778310] imx-dwmac 30bf0000.ethernet: Enabled RFS Flow TC (entries=8)
[    0.778323] imx-dwmac 30bf0000.ethernet: Enabling HW TC (entries=256, max_off=256)
[    0.778330] imx-dwmac 30bf0000.ethernet: Using 34 bits DMA width
[    0.809300] ALSA device list:
[    0.809311]   No soundcards found.
[    0.813503] BTRFS: device label root devid 1 transid 193058 /dev/root scanned by swapper/0 (1)
[    0.814034] BTRFS info (device mmcblk2p1): using crc32c (crc32c-generic) checksum algorithm
[    0.814053] BTRFS info (device mmcblk2p1): disk space caching is enabled
[    0.814057] BTRFS info (device mmcblk2p1): has skinny extents
[    0.820462] BTRFS info (device mmcblk2p1): enabling ssd optimizations
[    0.823089] VFS: Mounted root (btrfs filesystem) readonly on device 0:21.
[    0.823616] devtmpfs: mounted
[    0.824187] Freeing unused kernel memory: 3072K
[    0.835842] Run /sbin/init as init process
[    0.835847]   with arguments:
[    0.835852]     /sbin/init
[    0.835858]   with environment:
[    0.835861]     HOME=/
[    0.835865]     TERM=linux
[    0.941328] systemd[1]: systemd 250.5+ running in system mode (+PAM -AUDIT -SELINUX -APPARMOR +IMA -SMACK +SECCOMP -GCRYPT -GNUTLS -OPENSSL +ACL +BLKID -CURL -ELFUTILS -FIDO2 -IDN2 -IDN -IPTC +KMOD -LIBCRYPTSETUP +LIBFDISK -PCRE2 -PWQUALITY -P11KIT -QRENCODE -BZIP2 -LZ4 -XZ -ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=hybrid)
[    0.941840] systemd[1]: Detected architecture arm64.
[    0.977358] systemd[1]: Hostname set to <verdin-imx8mp>.
[    1.199758] systemd[1]: Queued start job for default target Multi-User System.
[    1.233740] systemd[1]: Created slice Slice /system/modprobe.
[    1.235125] systemd[1]: Created slice Slice /system/serial-getty.
[    1.236209] systemd[1]: Created slice User and Session Slice.
[    1.236430] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    1.236577] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    1.236800] systemd[1]: Reached target Host and Network Name Lookups.
[    1.236858] systemd[1]: Reached target Path Units.
[    1.236923] systemd[1]: Reached target Remote File Systems.
[    1.236967] systemd[1]: Reached target Slice Units.
[    1.237040] systemd[1]: Reached target Swaps.
[    1.237296] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    1.242122] systemd[1]: Listening on Journal Audit Socket.
[    1.242535] systemd[1]: Listening on Journal Socket (/dev/log).
[    1.242871] systemd[1]: Listening on Journal Socket.
[    1.243350] systemd[1]: Listening on Network Service Netlink Socket.
[    1.244889] systemd[1]: Listening on udev Control Socket.
[    1.245233] systemd[1]: Listening on udev Kernel Socket.
[    1.247977] systemd[1]: Mounting Huge Pages File System...
[    1.250766] systemd[1]: Mounting POSIX Message Queue File System...
[    1.253847] systemd[1]: Mounting Kernel Debug File System...
[    1.254271] systemd[1]: Kernel Trace File System was skipped because of a failed condition check (ConditionPathExists=/sys/kernel/tracing).
[    1.257428] systemd[1]: Mounting Temporary Directory /tmp...
[    1.260843] systemd[1]: Starting Create List of Static Device Nodes...
[    1.264116] systemd[1]: Starting Load Kernel Module configfs...
[    1.267445] systemd[1]: Starting Load Kernel Module drm...
[    1.270557] systemd[1]: Starting Load Kernel Module fuse...
[    1.275170] systemd[1]: Starting Journal Service...
[    1.279856] systemd[1]: Starting Load Kernel Modules...
[    1.281683] fuse: init (API version 7.34)
[    1.283139] systemd[1]: Starting Generate network units from Kernel command line...
[    1.286457] systemd[1]: Starting Remount Root and Kernel File Systems...
[    1.290223] systemd[1]: Starting Coldplug All udev Devices...
[    1.296580] systemd[1]: Mounted Huge Pages File System.
[    1.296967] systemd[1]: Mounted POSIX Message Queue File System.
[    1.297280] systemd[1]: Mounted Kernel Debug File System.
[    1.297633] systemd[1]: Mounted Temporary Directory /tmp.
[    1.298733] systemd[1]: Finished Create List of Static Device Nodes.
[    1.299652] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[    1.304594] systemd[1]: Finished Load Kernel Module configfs.
[    1.305559] systemd[1]: modprobe@drm.service: Deactivated successfully.
[    1.306310] systemd[1]: Finished Load Kernel Module drm.
[    1.307213] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[    1.308071] systemd[1]: Finished Load Kernel Module fuse.
[    1.313725] systemd[1]: Finished Generate network units from Kernel command line.
[    1.314965] galcore: loading out-of-tree module taints kernel.
[    1.325617] systemd[1]: Mounting FUSE Control File System...
[    1.326009] Galcore version 6.4.3.p4.398061
[    1.331750] systemd[1]: Mounting Kernel Configuration File System...
[    1.336484] systemd[1]: Mounted FUSE Control File System.
[    1.347287] systemd[1]: Mounted Kernel Configuration File System.
[    1.373823] systemd[1]: Started Journal Service.
[    1.414111] [drm] Initialized vivante 1.0.0 20170808 for 40000000.mix_gpu_ml on minor 1
[    1.430414] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    1.440773] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    1.448001] systemd-journald[201]: Received client request to flush runtime journal.
[    1.476794] wlan: Loading MWLAN driver
[    1.480651] audit: type=1334 audit(1729765837.728:2): prog-id=5 op=LOAD
[    1.480910] audit: type=1334 audit(1729765837.728:3): prog-id=6 op=LOAD
[    1.480947] wlan: Register to Bus Driver...
[    1.485395] vendor=0x02DF device=0x9141 class=0 function=1
[    1.490994] Attach moal handle ops, card interface type: 0x104
[    1.496878] rps set to 0 from module param
[    1.501905] SD8997: init module param from usr cfg
[    1.506785] card_type: SD8997, config block: 0
[    1.511278] cfg80211_wext=0xf
[    1.514299] max_vir_bss=1
[    1.516944] cal_data_cfg=none
[    1.519946] ps_mode = 1
[    1.522398] auto_ds = 1
[    1.524872] host_mlme=enable
[    1.527757] fw_name=nxp/sdiouart8997_combo_v4.bin
[    1.532500] SDIO: max_segs=128 max_seg_size=65535
[    1.537234] rx_work=1 cpu_num=4
[    1.540397] Enable moal_recv_amsdu_packet
[    1.540420] Attach mlan adapter operations.card_type is 0x104.
[    1.540737] wlan: Enable TX SG mode
[    1.540747] wlan: Enable RX SG mode
[    1.543925] Request firmware: nxp/sdiouart8997_combo_v4.bin
[    2.051810] random: crng init done
[    2.091296] caam 30900000.crypto: device ID = 0x0a16040100000100 (Era 9)
[    2.091313] caam 30900000.crypto: job rings = 2, qi = 0
[    2.092070] caam-snvs 30370000.caam-snvs: violation handlers armed - non-secure state
[    2.099981] Bluetooth: Core ver 2.22
[    2.100052] NET: Registered PF_BLUETOOTH protocol family
[    2.100056] Bluetooth: HCI device and connection manager initialized
[    2.100069] Bluetooth: HCI socket layer initialized
[    2.100075] Bluetooth: L2CAP socket layer initialized
[    2.100087] Bluetooth: SCO socket layer initialized
[    2.128751] imx-sdma 30bd0000.dma-controller: firmware found.
[    2.128910] imx-sdma 30bd0000.dma-controller: loaded firmware 4.5
[    2.141562] imx-sdma 30e00000.dma-controller: firmware found.
[    2.157934] imx-sdma 30e10000.dma-controller: firmware found.
[    2.167797] Bluetooth: HCI UART driver ver 2.3
[    2.167817] Bluetooth: HCI UART protocol H4 registered
[    2.167820] Bluetooth: HCI UART protocol BCSP registered
[    2.167905] Bluetooth: HCI UART protocol LL registered
[    2.167909] Bluetooth: HCI UART protocol ATH3K registered
[    2.168374] Bluetooth: HCI UART protocol Three-wire (H5) registered
[    2.168425] Bluetooth: HCI UART protocol QCA registered
[    2.179237] Bluetooth: HCI UART protocol Marvell registered
[    2.250760] wm8904 3-001a: revision A
[    2.275039] ina2xx 3-0040: error configuring the device: -6
[    2.281729] debugfs: File 'Headphone Jack' in directory 'dapm' already present!
[    2.294196] Wlan: FW download over, firmwarelen=625948 downloaded 625948
[    2.353395] BTRFS info: devid 1 device path /dev/root changed to /dev/mmcblk2p1 scanned by systemd-udevd (252)
[    2.853216] caam algorithms registered in /proc/crypto
[    2.857906] caam 30900000.crypto: caam pkc algorithms registered in /proc/crypto
[    2.858668] caam 30900000.crypto: rng crypto API alg registered prng-caam
[    2.858690] caam 30900000.crypto: registering rng-caam
[    2.860104] Device caam-keygen registered
[    3.003875] WLAN FW is active
[    3.006857] on_time is 3003089375
[    3.047542] FW country code WW does not match with US
[    3.047730] fw_cap_info=0x587c7fa3, dev_cap_mask=0xffffffff
[    3.047749] max_p2p_conn = 8, max_sta_conn = 8
[    3.049591] imx-dwmac 30bf0000.ethernet eth0: PHY [stmmac-0:07] driver [Microchip KSZ9131 Gigabit PHY] (irq=79)
[    3.076161] imx-dwmac 30bf0000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-0
[    3.076618] imx-dwmac 30bf0000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-1
[    3.077245] imx-dwmac 30bf0000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-2
[    3.077676] imx-dwmac 30bf0000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-3
[    3.078078] imx-dwmac 30bf0000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-4
[    3.087898] imx-dwmac 30bf0000.ethernet eth0: No Safety Features support found
[    3.087933] imx-dwmac 30bf0000.ethernet eth0: IEEE 1588-2008 Advanced Timestamp supported
[    3.091741] imx-dwmac 30bf0000.ethernet eth0: FPE workqueue start
[    3.091762] imx-dwmac 30bf0000.ethernet eth0: configuring for phy/rgmii-id link mode
[    3.096273] 8021q: adding VLAN 0 to HW filter on device eth0
[    3.109803] Register NXP 802.11 Adapter mlan0
[    3.114330] wlan: uap%d set max_mtu 2000
[    3.122913] imx-dwmac 30bf0000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off
[    3.125199] Register NXP 802.11 Adapter uap0
[    3.125226] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[    3.134189] Register NXP 802.11 Adapter wfd0
[    3.139283] wlan: version = SD8997----16.92.21.p84.4-MM6X16437.p3-GPL-(FP92)
[    3.147991] wlan: Register to Bus Driver Done
[    3.160603] wlan: Driver loaded successfully
[    3.281423] audit: type=1334 audit(1729765839.528:4): prog-id=7 op=LOAD
[    3.281840] audit: type=1334 audit(1729765839.528:5): prog-id=8 op=LOAD
[    3.477476] audit: type=1334 audit(1729765839.724:6): prog-id=9 op=LOAD
[    3.477648] audit: type=1334 audit(1729765839.724:7): prog-id=10 op=LOAD
[    3.578300] using random self ethernet address
[    3.578315] using random host ethernet address
[    3.636283] usb0: HOST MAC 2a:04:75:5f:bb:e6
[    3.636303] usb0: MAC 7e:63:d9:9f:b8:49
[    3.890785] audit: type=1334 audit(1729765840.136:8): prog-id=11 op=LOAD
[    3.892336] audit: type=1334 audit(1729765840.140:9): prog-id=12 op=LOAD
[    3.894111] NET: Registered PF_ALG protocol family
[    4.671181] wlan: mlan0 START SCAN
[    4.758895] wlan: SCAN COMPLETED: scanned AP count=0
[    7.045201] wlan: mlan0 START SCAN
[   12.349912] wlan: SCAN COMPLETED: scanned AP count=70
[   12.629110] wlan: HostMlme mlan0 send auth to bssid d6:XX:XX:XX:e4:73
[   12.642681] mlan0:
[   12.642694] wlan: HostMlme Auth received from d6:XX:XX:XX:e4:73
[   12.648324] CMD_RESP: cmd 0x121 error, result=0x2
[   12.648343] IOCTL failed: 000000009328a9e6 id=0x200000, sub_id=0x200024 action=2, status_code=0x3
[   12.657486] Get multi-channel policy failed
[   12.710492] wlan: HostMlme mlan0 Connected to bssid d6:XX:XX:XX:e4:73 successfully
[   12.724377] mlan0:
[   12.724391] wlan: Send EAPOL pkt to d6:XX:XX:XX:e4:73
[   12.731847] mlan0:
[   12.731861] wlan: Send EAPOL pkt to d6:XX:XX:XX:e4:73
[   12.733442] IPv6: ADDRCONF(NETDEV_CHANGE): mlan0: link becomes ready
[   12.737548] woal_cfg80211_set_rekey_data return: gtk_rekey_offload is DISABLE
[   14.361163] systemd-journald[201]: Time jumped backwards, rotating.
[   17.175487] wlan: mlan0 START SCAN
[   19.127335] AppControl: Failed: Larger Duplicate Beacon (40), old = 327, new = 401, space = 333, left = 49
[   19.127356] AppControl: Failed: Larger Duplicate Beacon (41), old = 335, new = 409, space = 341, left = 49
[   19.130527] AppControl: Failed: Larger Duplicate Beacon (42), old = 335, new = 409, space = 341, left = 49
[   19.130549] AppControl: Failed: Larger Duplicate Beacon (43), old = 330, new = 404, space = 336, left = 49
[   19.130562] AppControl: Failed: Larger Duplicate Beacon (44), old = 325, new = 399, space = 331, left = 49
[   19.133709] AppControl: Failed: Larger Duplicate Beacon (45), old = 356, new = 430, space = 362, left = 49
[   19.133737] AppControl: Failed: Larger Duplicate Beacon (40), old = 327, new = 401, space = 333, left = 49
[   19.133745] AppControl: Failed: Larger Duplicate Beacon (41), old = 335, new = 409, space = 341, left = 49
[   19.136906] AppControl: Failed: Larger Duplicate Beacon (42), old = 335, new = 409, space = 341, left = 49
[   19.136929] AppControl: Failed: Larger Duplicate Beacon (43), old = 330, new = 404, space = 336, left = 49
[   19.136942] AppControl: Failed: Larger Duplicate Beacon (44), old = 325, new = 399, space = 331, left = 49
[   19.140089] AppControl: Failed: Larger Duplicate Beacon (45), old = 356, new = 430, space = 362, left = 49
[   19.140111] AppControl: Failed: Larger Duplicate Beacon (40), old = 327, new = 401, space = 333, left = 49
[   19.140120] AppControl: Failed: Larger Duplicate Beacon (41), old = 335, new = 409, space = 341, left = 49
[   19.143300] AppControl: Failed: Larger Duplicate Beacon (42), old = 335, new = 409, space = 341, left = 49
[   19.143321] AppControl: Failed: Larger Duplicate Beacon (43), old = 330, new = 404, space = 336, left = 49
[   19.143334] AppControl: Failed: Larger Duplicate Beacon (44), old = 325, new = 399, space = 331, left = 49
[   19.146461] AppControl: Failed: Larger Duplicate Beacon (45), old = 356, new = 430, space = 362, left = 49
[   19.146483] AppControl: Failed: Larger Duplicate Beacon (40), old = 327, new = 401, space = 333, left = 49
[   23.844871] wlan: SCAN COMPLETED: scanned AP count=76
[   27.204997] wlan: mlan0 START SCAN
[   33.811465] wlan: SCAN COMPLETED: scanned AP count=70
[   34.823974] audit: type=1334 audit(1729765870.213:10): prog-id=12 op=UNLOAD
[   34.823995] audit: type=1334 audit(1729765870.213:11): prog-id=11 op=UNLOAD
[   37.224831] wlan: mlan0 START SCAN
[   43.744836] wlan: SCAN COMPLETED: scanned AP count=77
[   47.253422] wlan: mlan0 START SCAN
[   54.087420] wlan: SCAN COMPLETED: scanned AP count=74

Removed some AppControl: lines because of message length limits

Hi, I’m the Toradex AI Assistant. The Toradex Support team will follow up with you shortly!

Did you like my answer?

:+1: :-1:


Based on the context provided, it seems that the Verdin iMX8MP boards are experiencing WiFi driver timeouts and unresponsiveness, which could be related to background scanning operations and firmware loading issues. Here are some suggestions to address the problem:

  1. Firmware Compatibility: Ensure that the firmware used with the proprietary driver is compatible with your current kernel version and hardware configuration. The logs indicate failures in downloading firmware, which might be a critical factor in the WiFi module’s failure to respond.

  2. Driver Updates: Check for any updates or patches for the WiFi driver that might address the timeout issues, especially those related to background scanning. This could involve checking both the kernel-included driver and the proprietary driver for any recent updates.

  3. Alternative Drivers: If the proprietary driver continues to exhibit issues, consider testing with alternative drivers or configurations to see if the problem persists. This might involve using a different version of the driver or a different driver altogether if available.

  4. Monitor Logs: Continue to monitor dmesg logs for any additional error messages that might provide further insight into the underlying cause of the driver timeouts. This can help in identifying any patterns or specific triggers for the issue.

  5. Testing on Reference Hardware: Although you mentioned that you are not in a position to try this with a reference image on a reference carrier board, it is still a recommended step to isolate whether the issue is specific to your custom carrier board or a broader compatibility issue.

  6. Background Scanning: Since the issue might be related to background scanning, consider disabling or modifying the scanning behavior to see if it affects the frequency of the timeouts.

These steps should help in diagnosing and potentially resolving the WiFi driver issues on your Verdin iMX8MP boards. If the problem persists, further investigation into the specific interactions between the driver, firmware, and hardware might be necessary.

Please, also check if these links can help you solve your problem:

Verdin IMX8MM Bluetooth Hci Timeout TorizonCore 6.0.1.

Hello @SvenAlmgren,

Thanks for providing the logs and all the relevant information. May I know when exactly does this crash happen? For example, right away after booting, after some time of activity, while performing/executing some actions?

Also, how are you using the wifi? Is it in client mode or access point mode?