2020-02-15 10:49:30

by Paul Menzel

[permalink] [raw]
Subject: iwlwifi: Error: Response NULL in 'NVM_ACCESS_CMD'

Dear Linux folks,


With Linux 5.5-rc5 from Debian experimental, I already use since
February 4th, today I saw the error below for the first time. I am not
able to reproduce this.

> [ 0.000000] microcode: microcode updated early to revision 0x2e, date = 2019-06-13
> [ 0.000000] Linux version 5.5.0-rc5-amd64 ([email protected]) (gcc version 9.2.1 20200104 (Debian 9.2.1-22)) #1 SMP Debian 5.5~rc5-1~exp1 (2020-01-06)
> [ 0.000000] Command line: BOOT_IMAGE=/vmlinuz-5.5.0-rc5-amd64 root=UUID=aa6034bb-8cc1-4111-a0a7-9b3f5e13e281 ro quiet noisapnp initcall_debug log_buf_len=8M random.trust_cpu=on cryptomgr.notests i915.fastboot=0 systemd.verity=0
> […]
> [ 6.026320] calling iwl_drv_init+0x0/0x1000 [iwlwifi] @ 299
> [ 6.026321] Intel(R) Wireless WiFi driver for Linux
> [ 6.026321] Copyright(c) 2003- 2015 Intel Corporation
>
> [ 6.062892] probe of 0000:02:00.0 returned 1 after 19023 usecs
> [ 6.062951] initcall iwl_drv_init+0x0/0x1000 [iwlwifi] returned 0 after 3570 usecs
> […]
> [ 6.077542] iwlwifi 0000:02:00.0: firmware: direct-loading firmware iwlwifi-7265D-29.ucode
> [ 6.077826] iwlwifi 0000:02:00.0: loaded firmware version 29.1044073957.0 op_mode iwlmvm
> […]
> [ 6.195555] calling ieee80211_init+0x0/0x2a [mac80211] @ 364
> [ 6.195582] initcall ieee80211_init+0x0/0x2a [mac80211] returned 0 after 7 usecs
> […]
> [ 6.276513] iwlwifi 0000:02:00.0: Detected Intel(R) Dual Band Wireless AC 7265, REV=0x210
> [ 6.302981] calling vmx_init+0x0/0xe9 [kvm_intel] @ 321
> [ 6.309520] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio.
> [ 6.309522] iwlwifi 0000:02:00.0: reporting RF_KILL (radio disabled)
> [ 6.309680] iwlwifi 0000:02:00.0: Error: Response NULL in 'NVM_ACCESS_CMD'
> [ 6.309730] iwlwifi 0000:02:00.0: base HW address: 34:02:86:45:19:33
> [ 6.309743] initcall vmx_init+0x0/0xe9 [kvm_intel] returned 0 after 6594 usecs
> [ 6.309744] iwlwifi 0000:02:00.0: Failed to read NVM: -5
> [ 6.309747] iwlwifi 0000:02:00.0: Collecting data: trigger 16 fired.
> [ 6.309797] iwlwifi 0000:02:00.0: HCMD_ACTIVE already clear for command NVM_ACCESS_CMD
> [ 6.311058] iwlwifi 0000:02:00.0: Start IWL Error Log Dump:
> [ 6.311079] iwlwifi 0000:02:00.0: Status: 0x00000041, count: 6
> [ 6.311096] iwlwifi 0000:02:00.0: Loaded firmware version: 29.1044073957.0
> [ 6.311118] iwlwifi 0000:02:00.0: 0x00000084 | NMI_INTERRUPT_UNKNOWN
> [ 6.311139] iwlwifi 0000:02:00.0: 0x000002F0 | trm_hw_status0
> [ 6.311157] iwlwifi 0000:02:00.0: 0x00000000 | trm_hw_status1
> [ 6.311175] iwlwifi 0000:02:00.0: 0x00041702 | branchlink2
> [ 6.311192] iwlwifi 0000:02:00.0: 0x00044696 | interruptlink1
> [ 6.311210] iwlwifi 0000:02:00.0: 0x00000188 | interruptlink2
> [ 6.311228] iwlwifi 0000:02:00.0: 0x00000000 | data1
> [ 6.311243] iwlwifi 0000:02:00.0: 0x00000080 | data2
> [ 6.311259] iwlwifi 0000:02:00.0: 0x07030000 | data3
> [ 6.311275] iwlwifi 0000:02:00.0: 0x00000000 | beacon time
> [ 6.311292] iwlwifi 0000:02:00.0: 0x00002BA4 | tsf low
> [ 6.311309] iwlwifi 0000:02:00.0: 0x00000000 | tsf hi
> [ 6.311325] iwlwifi 0000:02:00.0: 0x00000000 | time gp1
> [ 6.311341] iwlwifi 0000:02:00.0: 0x00002BA5 | time gp2
> [ 6.311358] iwlwifi 0000:02:00.0: 0x00000009 | uCode revision type
> [ 6.311377] iwlwifi 0000:02:00.0: 0x0000001D | uCode version major
> [ 6.311396] iwlwifi 0000:02:00.0: 0x3E3B4DE5 | uCode version minor
> [ 6.311415] iwlwifi 0000:02:00.0: 0x00000210 | hw version
> [ 6.311432] iwlwifi 0000:02:00.0: 0x00489200 | board version
> [ 6.311450] iwlwifi 0000:02:00.0: 0x000B0188 | hcmd
> [ 6.311465] iwlwifi 0000:02:00.0: 0x00022000 | isr0
> [ 6.311481] iwlwifi 0000:02:00.0: 0x00000000 | isr1
> [ 6.311496] iwlwifi 0000:02:00.0: 0x00000002 | isr2
> [ 6.311511] iwlwifi 0000:02:00.0: 0x004000C0 | isr3
> [ 6.311526] iwlwifi 0000:02:00.0: 0x00000000 | isr4
> [ 6.311541] iwlwifi 0000:02:00.0: 0x000B0188 | last cmd Id
> [ 6.311558] iwlwifi 0000:02:00.0: 0x00000000 | wait_event
> [ 6.311575] iwlwifi 0000:02:00.0: 0x000010CC | l2p_control
> [ 6.311592] iwlwifi 0000:02:00.0: 0x00000000 | l2p_duration
> [ 6.311609] iwlwifi 0000:02:00.0: 0x00000000 | l2p_mhvalid
> [ 6.311626] iwlwifi 0000:02:00.0: 0x00000000 | l2p_addr_match
> [ 6.311644] iwlwifi 0000:02:00.0: 0x00000007 | lmpm_pmg_sel
> [ 6.311661] iwlwifi 0000:02:00.0: 0x14031202 | timestamp
> [ 6.311678] iwlwifi 0000:02:00.0: 0x00340818 | flow_handler
> [ 6.311841] iwlwifi 0000:02:00.0: Fseq Registers:
> [ 6.312013] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_ERROR_CODE
> [ 6.312188] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_TOP_INIT_VERSION
> [ 6.312364] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_CNVIO_INIT_VERSION
> [ 6.312542] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_OTP_VERSION
> [ 6.312717] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_TOP_CONTENT_VERSION
> [ 6.313410] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_ALIVE_TOKEN
> [ 6.314111] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_CNVI_ID
> [ 6.314788] iwlwifi 0000:02:00.0: 0x00000000 | FSEQ_CNVR_ID
> [ 6.315432] iwlwifi 0000:02:00.0: 0x00000000 | CNVI_AUX_MISC_CHIP
> [ 6.316078] iwlwifi 0000:02:00.0: 0x00000000 | CNVR_AUX_MISC_CHIP
> [ 6.316688] iwlwifi 0000:02:00.0: 0x00000000 | CNVR_SCU_SD_REGS_SD_REG_DIG_DCDC_VTRIM
> [ 6.317312] iwlwifi 0000:02:00.0: 0x00000000 | CNVR_SCU_SD_REGS_SD_REG_ACTIVE_VDIG_MIRROR
> [ 6.317963] iwlwifi 0000:02:00.0: Firmware not running - cannot dump error
> […]
> [ 6.331182] iwlwifi 0000:02:00.0: Failed to run INIT ucode: -5

Please find the full output of `dmesg` attached.


Kind regards,

Paul


Attachments:
=?UTF-8?Q?20200215=E2=80=93linux-5=2E5-rc5=E2=80=93messages=2Etxt?= (167.99 kB)