[Bug 274990] [iwlwifi, ax211] wpa_cli scan_results times out after 10s with no output, making installer wifi unusable

From: <bugzilla-noreply_at_freebsd.org>
Date: Fri, 10 Nov 2023 01:55:02 UTC
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=274990

--- Comment #5 from Ed Maste <emaste@freebsd.org> ---
(In reply to Bjoern A. Zeeb from comment #2)
> Instead of running ifconfig wlan0 scan what does ifconfig wlan0 list scan show
> (i.e., did we have scan results already and wpa didn't get them)?

Following up for posterity, it's awkward trying to reproduce this via the
installer (which does not get around to configuring the network until after
disk setup.

From the installed system I tried wpa_cli scan followed by wpa_cli scan_results
which timed out. ifconfig wlan0 list scan does show all of the expected
networks.

> Is this new?  I use wpa_cli regularly but after a full VM update to main Nov 3 I do see
> it too now.  I definitively used scan and scan_results a lot a while ago (around 
> 3f382eb23b9f).

This is a new machine I just purchased for FreeBSD bring-up, and the 14.0-RC4
installer is the first time I've tried FreeBSD on it.

Moving on from scanning and attempting to use the configured network:

iwlwifi0: WRT: Invalid buffer destination
iwlwifi0: WFPM_UMAC_PD_NOTIFICATION: 0x20
iwlwifi0: WFPM_LMAC2_PD_NOTIFICATION: 0x1f
iwlwifi0: WFPM_AUTH_KEY_0: 0x90
iwlwifi0: CNVI_SCU_SEQ_DATA_DW9: 0x0
iwlwifi0: RFIm is deactivated, reason = 4
iwlwifi0: RFIm is deactivated, reason = 4
wlan0: Ethernet address: XX:XX:XX:XX:XX:XX
lo0: link state changed to UP
wlan0: link state changed to UP
wlan0: link state changed to DOWN
iwlwifi0: Not associated and the session protection is over already...
wlan0: link state changed to UP
wlan0: link state changed to DOWN
lo0: link state changed to DOWN
iwlwifi0: WRT: Invalid buffer destination
iwlwifi0: WFPM_UMAC_PD_NOTIFICATION: 0x20
iwlwifi0: WFPM_LMAC2_PD_NOTIFICATION: 0x1f
iwlwifi0: WFPM_AUTH_KEY_0: 0x90
iwlwifi0: CNVI_SCU_SEQ_DATA_DW9: 0x0
iwlwifi0: RFIm is deactivated, reason = 4
iwlwifi0: RFIm is deactivated, reason = 4
wlan0: Ethernet address: XX:XX:XX:XX:XX:XX
lo0: link state changed to UP
wlan0: ieee80211_new_state_locked: pending SCAN -> AUTH transition lost
iwlwifi0: lkpi_iv_newstate: error -5 during state transition 2 (AUTH) -> 1
(SCAN)
WARNING vif_link->ap_sta_id != 0xFF failed at
/usr/src/sys/contrib/dev/iwlwifi/mvm/mld-sta.c:612
iwlwifi0: Microcode SW error detected. Restarting 0x0.
iwlwifi0: Start IWL Error Log Dump:
iwlwifi0: Transport status: 0x0000004B, valid: 6
iwlwifi0: Loaded firmware version: 83.e8f84e98.0 so-a0-gf-a0-83.ucode
iwlwifi0: 0x00000071 | NMI_INTERRUPT_UMAC_FATAL    
iwlwifi0: 0x00008210 | trm_hw_status0
iwlwifi0: 0x00000000 | trm_hw_status1
iwlwifi0: 0x004DB338 | branchlink2
iwlwifi0: 0x004D119A | interruptlink1
iwlwifi0: 0x004D119A | interruptlink2
iwlwifi0: 0x0000B75A | data1
iwlwifi0: 0x00000010 | data2
iwlwifi0: 0x00000000 | data3
iwlwifi0: 0x00000000 | beacon time
iwlwifi0: 0x00D8C66D | tsf low
iwlwifi0: 0x00000000 | tsf hi
iwlwifi0: 0x00000000 | time gp1
iwlwifi0: 0x00DA0A07 | time gp2
iwlwifi0: 0x00000001 | uCode revision type
iwlwifi0: 0x00000053 | uCode version major
iwlwifi0: 0xE8F84E98 | uCode version minor
iwlwifi0: 0x00000370 | hw version
iwlwifi0: 0x00480002 | board version
iwlwifi0: 0x802DFC01 | hcmd
iwlwifi0: 0x24020000 | isr0
iwlwifi0: 0x01000000 | isr1
iwlwifi0: 0x48F00002 | isr2
iwlwifi0: 0x00C2000C | isr3
iwlwifi0: 0x00200000 | isr4
iwlwifi0: 0x0A01001C | last cmd Id
iwlwifi0: 0x0000B75A | wait_event
iwlwifi0: 0x000000D4 | l2p_control
iwlwifi0: 0x00010034 | l2p_duration
iwlwifi0: 0x00000007 | l2p_mhvalid
iwlwifi0: 0x00000000 | l2p_addr_match
iwlwifi0: 0x00000009 | lmpm_pmg_sel
iwlwifi0: 0x00000000 | timestamp
iwlwifi0: 0x0000C8F4 | flow_handler
iwlwifi0: Start IWL Error Log Dump:
iwlwifi0: Transport status: 0x0000004B, valid: 7
iwlwifi0: 0x20101F05 | ADVANCED_SYSASSERT
iwlwifi0: 0x00000000 | umac branchlink1
iwlwifi0: 0x80471ABC | umac branchlink2
iwlwifi0: 0x010A4346 | umac interruptlink1
iwlwifi0: 0x00000000 | umac interruptlink2
iwlwifi0: 0x00000000 | umac data1
iwlwifi0: 0x00000003 | umac data2
iwlwifi0: 0xDEADBEEF | umac data3
iwlwifi0: 0x00000053 | umac major
iwlwifi0: 0xE8F84E98 | umac minor
iwlwifi0: 0x00DA0A01 | frame pointer
iwlwifi0: 0xC0886BEC | stack pointer
iwlwifi0: 0x00440308 | last host cmd
iwlwifi0: 0x00000000 | isr status reg
iwlwifi0: IML/ROM dump:
iwlwifi0: 0x00000B03 | IML/ROM error/state
iwlwifi0: 0x000080C5 | IML/ROM data1
iwlwifi0: 0x00000090 | IML/ROM WFPM_AUTH_KEY_0
iwlwifi0: Fseq Registers:
iwlwifi0: 0x60000000 | FSEQ_ERROR_CODE
iwlwifi0: 0x803E0003 | FSEQ_TOP_INIT_VERSION
iwlwifi0: 0x00190003 | FSEQ_CNVIO_INIT_VERSION
iwlwifi0: 0x0000A652 | FSEQ_OTP_VERSION
iwlwifi0: 0x00000003 | FSEQ_TOP_CONTENT_VERSION
iwlwifi0: 0x4552414E | FSEQ_ALIVE_TOKEN
iwlwifi0: 0x00080400 | FSEQ_CNVI_ID
iwlwifi0: 0x00401410 | FSEQ_CNVR_ID
iwlwifi0: 0x00080400 | CNVI_AUX_MISC_CHIP
iwlwifi0: 0x00401410 | CNVR_AUX_MISC_CHIP
iwlwifi0: 0x00009061 | CNVR_SCU_SD_REGS_SD_REG_DIG_DCDC_VTRIM
iwlwifi0: 0x00000061 | CNVR_SCU_SD_REGS_SD_REG_ACTIVE_VDIG_MIRROR
iwlwifi0: 0x00190003 | FSEQ_PREV_CNVIO_INIT_VERSION
iwlwifi0: 0x003E0003 | FSEQ_WIFI_FSEQ_VERSION
iwlwifi0: 0xAF793790 | FSEQ_BT_FSEQ_VERSION
iwlwifi0: 0x000001D6 | FSEQ_CLASS_TP_VERSION
iwlwifi0: UMAC CURRENT PC: 0x80493890
iwlwifi0: LMAC1 CURRENT PC: 0xd0
iwlwifi0: WRT: Collecting data: ini trigger 4 fired (delay=0ms).
iwlwifi0: FW error in SYNC CMD MAC_CONFIG_CMD
#0 0xffffffff80daa3bb at linux_dump_stack+0x1b
#1 0xffffffff83673783 at iwl_trans_txq_send_hcmd+0x3f3
#2 0xffffffff8360f29e at iwl_trans_send_cmd+0xce
#3 0xffffffff83652329 at iwl_mvm_send_cmd_pdu+0x49
#4 0xffffffff83655d56 at iwl_mvm_mld_mac_ctx_send+0x316
#5 0xffffffff83656f55 at iwl_mvm_mld_link_info_changed+0x3c5
#6 0xffffffff80d9d576 at lkpi_sta_assoc_to_run+0x2a6
#7 0xffffffff80da3f5a at lkpi_iv_newstate+0x39a
#8 0xffffffff80cd463a at ieee80211_newstate_cb+0x17a
#9 0xffffffff80ba5922 at taskqueue_run_locked+0x182
#10 0xffffffff80ba6bb2 at taskqueue_thread_loop+0xc2
#11 0xffffffff80afdb0f at fork_exit+0x7f
#12 0xffffffff80fe488e at fork_trampoline+0xe
iwlwifi0: Failed to send MAC_CONFIG_CMD (action:2): -5
iwlwifi0: failed to update MAC ...
iwlwifi0: failed to update power mode
iwlwifi0: mcast filter cmd error. ret=-5
iwlwifi0: Failed to synchronize multicast groups update
WARNING iwl_mvm_enable_beacon_filter(mvm, vif, 0) failed at
/usr/src/sys/contrib/dev/iwlwifi/mvm/mac80211.c:3806
iwlwifi0: Failed to send MAC_CONFIG_CMD (action:2): -5
iwlwifi0: Failed to send MAC_CONFIG_CMD (action:2): -5
iwlwifi0: failed to update MAC ...
wlan0: link state changed to UP
iwlwifi0: Failed to send flush command (-5)
iwlwifi0: flush request fail
iwlwifi0: Failed to send flush command (-5)
iwlwifi0: flush request fail
iwlwifi0: Couldn't send the SESSION_PROTECTION_CMD
iwlwifi0: iwl_trans_wait_txq_empty bad state = 0
iwlwifi0: iwl_trans_wait_txq_empty bad state = 0
iwlwifi0: Failed to trigger RX queues sync (-5)
wlan0: link state changed to DOWN
iwlwifi0: Failed to synchronize multicast groups update
iwlwifi0: Failed to send MAC_CONFIG_CMD (action:2): -5
iwlwifi0: failed to update MAC ...
iwlwifi0: Failed to send flush command (-5)
iwlwifi0: Failed to send MAC_CONFIG_CMD (action:2): -5
iwlwifi0: failed to update MAC ...
iwlwifi0: Failed to send LINK_CONFIG_CMD (action:2): -5
iwlwifi0: PHY ctxt cmd error. ret=-5
iwlwifi0: Scan failed! ret -5
iwlwifi0: ERROR: lkpi_ic_scan_start: hw_scan returned -5
iwlwifi0: Scan failed! ret -5
iwlwifi0: ERROR: lkpi_ic_scan_start: hw_scan returned -5
iwlwifi0: Scan failed! ret -5
iwlwifi0: ERROR: lkpi_ic_scan_start: hw_scan returned -5
iwlwifi0: Scan failed! ret -5
iwlwifi0: ERROR: lkpi_ic_scan_start: hw_scan returned -5

-- 
You are receiving this mail because:
You are the assignee for the bug.