iwlwifi AC9260 Random Crashes CMD_DTS_MEASUREMENT_TRIGGER_WIDE

TemporalShift · 2019-12-26 01:17:12

Hi,

System Info:
Current Kernel: 5.4.6-arch3-1
System is fully up to date at time of post.
linux-firmware version: 20191220.6871bff-1

/usr/lib/firmware> ls | grep iwlwifi-9260
iwlwifi-9260-th-b0-jf-b0-33.ucode
iwlwifi-9260-th-b0-jf-b0-34.ucode
iwlwifi-9260-th-b0-jf-b0-38.ucode
iwlwifi-9260-th-b0-jf-b0-41.ucode
iwlwifi-9260-th-b0-jf-b0-43.ucode
iwlwifi-9260-th-b0-jf-b0-46.ucode

lspci -v reports:

17:00.0 Network controller: Intel Corporation Wireless-AC 9260 (rev 29)
        DeviceName: Broadcom 5762
        Subsystem: Intel Corporation Wireless-AC 9260
        Flags: bus master, fast devsel, latency 0, IRQ 29
        Memory at f7600000 (64-bit, non-prefetchable) [size=16K]
        Capabilities: <access denied>
        Kernel driver in use: iwlwifi
        Kernel modules: iwlwifi

The Bug:
On large amounts of utilization of the network connection iwlwifi crashes and the connection becomes unresponsive. By toggling the radio off and on again the connection can be used again immediately. It can be easily triggered with a fast downloading torrent. The key line from kernel logs appears to be: FW error in SYNC CMD CMD_DTS_MEASUREMENT_TRIGGER_WIDE. This is however not the only error I am seeing after a crash (but it does seem the most common). I am also seeing variants including:

FW error in SYNC CMD SCAN_CFG_CMD
FW error in SYNC CMD STATISTICS_CMD

Potential Link with Windows Dual-Boot:
If I use Linux for several days in a row without any Windows usage the issue seems to stop occurring. I do not know the exact amount of time that needs to elapse without Windows use before the issue goes away. It could be a number of boots, a number of hours or a number of hours with the system entirely powered off. After using Windows again the issue begins to occur.

Fast startup is disabled and has never been enabled. It is not the issue. I have seen similar anecdotes in my searching re: the Windows dual boot seeming to set off the issue. There is no evidence to prove it but I am strongly suspicious of a link.

Logs from journalctl of a crash:

Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: Microcode SW error detected. Restarting 0x0.
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: Start IWL Error Log Dump:
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: Status: 0x00000040, count: 6
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: Loaded firmware version: 46.ceaaecdc.0
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x000022CE | ADVANCED_SYSASSERT          
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x05B0A2F0 | trm_hw_status0
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | trm_hw_status1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00488BCA | branchlink2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x004793FE | interruptlink1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | interruptlink2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000012C | data1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | data2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x04000000 | data3
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x03C1221B | beacon time
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0xCD859E13 | tsf low
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000108 | tsf hi
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | time gp1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x7936110C | time gp2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000001 | uCode revision type
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000002E | uCode version major
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0xCEAAECDC | uCode version minor
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000321 | hw version
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00C89004 | board version
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0ADB001C | hcmd
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0xA6E93882 | isr0
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00040000 | isr1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00281802 | isr2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x404179CD | isr3
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | isr4
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0AD3001C | last cmd Id
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0001AE66 | wait_event
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00004288 | l2p_control
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000020 | l2p_duration
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x000003BF | l2p_mhvalid
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x000000E7 | l2p_addr_match
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000000D | lmpm_pmg_sel
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x20111546 | timestamp
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x14587070 | flow_handler
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | ADVANCED_SYSASSERT
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac branchlink1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac branchlink2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac interruptlink1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac interruptlink2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac data1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac data2
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac data3
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac major
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac minor
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | frame pointer
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | stack pointer
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | last host cmd
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | isr status reg
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: Fseq Registers:
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x5D410010 | FSEQ_ERROR_CODE
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | FSEQ_TOP_INIT_VERSION
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0xBE7FBAFE | FSEQ_CNVIO_INIT_VERSION
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000A371 | FSEQ_OTP_VERSION
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x73ED9DFF | FSEQ_TOP_CONTENT_VERSION
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x10841000 | FSEQ_ALIVE_TOKEN
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0xE97D666F | FSEQ_CNVI_ID
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0xC7210097 | FSEQ_CNVR_ID
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x01000200 | CNVI_AUX_MISC_CHIP
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x01300202 | CNVR_AUX_MISC_CHIP
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000485B | CNVR_SCU_SD_REGS_SD_REG_DIG_DCDC_VTRIM
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 0x0BADCAFE | CNVR_SCU_SD_REGS_SD_REG_ACTIVE_VDIG_MIRROR
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: iwlwifi transaction failed, dumping registers
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: iwlwifi device config registers:
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000000: 25268086 00100406 02800029 00000010 f7600004 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000020: 00000000 00000000 00000000 00148086 00000000 000000c8 00000000 000001ff
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000040: 00028010 10008ec0 00110c10 0045e812 10120040 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000060: 00000000 00080812 00000005 00000000 00000002 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000080: 800f0011 00002000 00003000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 000000a0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 000000c0: 00000000 00000000 c823d001 0d000008 00804005 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 000000e0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000100: 14c10001 00010000 00000000 00462031 00002000 00000000 00000010 4a000008
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000120: 00000020 17000f00 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000140: 14c00000 ff000000 000000ff 15410018 00000000 0001001e 00481e1f 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: iwlwifi device memory mapped registers:
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000000: 00c89004 00000040 00000000 00000000 00000000 00000000 00027e1f 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000020: 00000000 0c040005 00000321 d55555d5 d55555d5 d55555d5 80008040 041f0044
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: iwlwifi device AER capability structure:
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000000: 14c10001 00010000 00000000 00462031 00002000 00000000 00000010 4a000008
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: 00000020: 00000020 17000f00 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: iwlwifi parent port (0000:16:00.0) config registers:
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000000: 43c71022 00100407 06040001 00010010 00000000 00000000 00171716 000001f1
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000020: f760f760 0001fff1 00000000 00000000 00000000 00000050 00000000 001201ff
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000040: 00000000 00000000 00000000 00000000 00817805 fee00000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000060: 00000000 00000000 00077811 00002000 00002080 00000000 c0438001 00000008
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000080: 0162c010 00008022 00102910 00737c12 70120040 00080d00 01480000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 000000a0: 00000000 00000800 00000000 00000006 00000002 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 000000c0: 0000000d 33061b21 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 000000e0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000100: 20010001 00000000 00000000 00062031 00000000 00002000 00000020 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000120: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000140: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000160: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000180: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 000001a0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 000001c0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 000001e0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:16:00.0: 00000200: 40010019 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: iwlwifi root port (0000:00:01.3) AER cap structure:
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:00:01.3: 00000000: 27020001 00000000 04400000 00462030 00000000 00006000 000000a0 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:00:01.3: 00000020: 00000000 00000000 00000000 00000007 00000000 00000000
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: FW error in SYNC CMD CMD_DTS_MEASUREMENT_TRIGGER_WIDE
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: Failed to get the temperature (err=-5)
Dec 25 21:08:37 jack-define kernel: iwlwifi 0000:17:00.0: Firmware not running - cannot dump error

I am continuing to investigate this and will be conducting a number of experiments tomorrow to see if I can reliably instantly trigger the error by rebooting straight from Windows into Arch and then pulling a very fast download. I will then be repeating my experiment after a number of repeated boots into Arch with no Windows involvement, and possibly some other scenarios as well.

If you are reading this and you're seeing a similar issue, please make a comment and let me know:

Kernel version
Firmware version
If you are using Windows in a dual boot

I particularly want to hear from you if you're experiencing a similar issue and do not use Windows in a dual boot because that will run counter to my current hypothesis.

I will be escalating this to Linux kernel/iwlwifi maintainers at some point but want to have some more data before I do.

Last edited by TemporalShift (2019-12-26 01:19:42)

TemporalShift · 2019-12-26 01:34:01

Interesting addition, I just triggered a crash by initiating a fast download whilst watching output on journalctl -f -p emerg..err:

Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: Microcode SW error detected. Restarting 0x0.
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: Start IWL Error Log Dump:
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: Status: 0x00000040, count: 6
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: Loaded firmware version: 46.ceaaecdc.0
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x000022CE | ADVANCED_SYSASSERT          
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x059026F7 | trm_hw_status0
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | trm_hw_status1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00488BCA | branchlink2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x004793FE | interruptlink1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | interruptlink2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000012C | data1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | data2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x04000000 | data3
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0xE4C17BF1 | beacon time
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x6774E425 | tsf low
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000010C | tsf hi
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | time gp1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x129A3779 | time gp2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000001 | uCode revision type
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000002E | uCode version major
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0xCEAAECDC | uCode version minor
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000321 | hw version
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00C89004 | board version
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0BC6001C | hcmd
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0xA7F93802 | isr0
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00040000 | isr1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00001802 | isr2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x404139CD | isr3
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | isr4
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0BC5001C | last cmd Id
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0001AE66 | wait_event
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00004A88 | l2p_control
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00003C20 | l2p_duration
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x000003BF | l2p_mhvalid
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x000000E7 | l2p_addr_match
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000000D | lmpm_pmg_sel
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x20111546 | timestamp
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x11E0D0D0 | flow_handler
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | ADVANCED_SYSASSERT
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac branchlink1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac branchlink2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac interruptlink1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac interruptlink2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac data1
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac data2
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac data3
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac major
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac minor
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | frame pointer
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | stack pointer
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | last host cmd
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | isr status reg
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: Fseq Registers:
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x5D410010 | FSEQ_ERROR_CODE
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | FSEQ_TOP_INIT_VERSION
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0xBE7FBAFE | FSEQ_CNVIO_INIT_VERSION
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000A371 | FSEQ_OTP_VERSION
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x73ED9DFF | FSEQ_TOP_CONTENT_VERSION
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x10841000 | FSEQ_ALIVE_TOKEN
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0xE97D666F | FSEQ_CNVI_ID
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0xC7210097 | FSEQ_CNVR_ID
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x01000200 | CNVI_AUX_MISC_CHIP
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x01300202 | CNVR_AUX_MISC_CHIP
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000485B | CNVR_SCU_SD_REGS_SD_REG_DIG_DCDC_VTRIM
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: 0x0BADCAFE | CNVR_SCU_SD_REGS_SD_REG_ACTIVE_VDIG_MIRROR
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: FW error in SYNC CMD CMD_DTS_MEASUREMENT_TRIGGER_WIDE
Dec 26 01:26:25 jack-define kernel: iwlwifi 0000:17:00.0: Failed to get the temperature (err=-5)

The download continued without any noticeable drop in speed and I was still able to browse normally in Firefox, i.e. my connection remained stable despite the issue.

3 minutes and 25 seconds later I see further errors logged and now my connection does die:

Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Error sending STATISTICS_CMD: time out after 2000ms.
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Current CMD queue read_ptr 165 write_ptr 166
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Start IWL Error Log Dump:
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Status: 0x00000040, count: 6
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Loaded firmware version: 46.ceaaecdc.0
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000084 | NMI_INTERRUPT_UNKNOWN       
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x000022F0 | trm_hw_status0
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | trm_hw_status1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00488BCA | branchlink2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x004793FE | interruptlink1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x004793FE | interruptlink2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0001AE66 | data1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xFF000000 | data2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xE000000C | data3
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xF2C13608 | beacon time
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x73B069FD | tsf low
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000010C | tsf hi
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | time gp1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0C2C9811 | time gp2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000001 | uCode revision type
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000002E | uCode version major
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xCEAAECDC | uCode version minor
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000321 | hw version
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00C89004 | board version
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0BF0001C | hcmd
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00012002 | isr0
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | isr1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00001802 | isr2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0041F4C0 | isr3
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | isr4
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0BEF001C | last cmd Id
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0001AE66 | wait_event
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00004288 | l2p_control
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000020 | l2p_duration
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | l2p_mhvalid
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x000000E7 | l2p_addr_match
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000000D | lmpm_pmg_sel
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x20111546 | timestamp
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x13145858 | flow_handler
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Start IWL Error Log Dump:
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Status: 0x00000040, count: 7
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x20000066 | NMI_INTERRUPT_HOST
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | umac branchlink1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xC008893A | umac branchlink2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xC0084444 | umac interruptlink1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xC0084444 | umac interruptlink2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x01000000 | umac data1
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xC0084444 | umac data2
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xDEADBEEF | umac data3
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000002E | umac major
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xCEAAECDC | umac minor
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0C2C97FF | frame pointer
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xC088627C | stack pointer
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00A5019C | last host cmd
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | isr status reg
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Fseq Registers:
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x5D410010 | FSEQ_ERROR_CODE
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x00000000 | FSEQ_TOP_INIT_VERSION
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xBE7FBAFE | FSEQ_CNVIO_INIT_VERSION
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000A371 | FSEQ_OTP_VERSION
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x73ED9DFF | FSEQ_TOP_CONTENT_VERSION
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x10841000 | FSEQ_ALIVE_TOKEN
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xE97D666F | FSEQ_CNVI_ID
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0xC7210097 | FSEQ_CNVR_ID
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x01000200 | CNVI_AUX_MISC_CHIP
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x01300202 | CNVR_AUX_MISC_CHIP
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0000485B | CNVR_SCU_SD_REGS_SD_REG_DIG_DCDC_VTRIM
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: 0x0BADCAFE | CNVR_SCU_SD_REGS_SD_REG_ACTIVE_VDIG_MIRROR
Dec 26 01:29:50 jack-define kernel: iwlwifi 0000:17:00.0: Failed to get the temperature (err=-5)
Dec 26 01:29:51 jack-define kernel: iwlwifi 0000:17:00.0: Queue 0 is active on fifo 7 and stuck for 2500 ms. SW [165, 166] HW [166, 166] FH TRB=0x07000a5

I then waited a further 3 minutes and my connection did not recover. I then cycled the radio and I was back up.

samurai · 2019-12-26 08:58:09

What about linux-lts?

TemporalShift · 2019-12-26 13:46:26

Testing linux-lts today:

> uname -r
4.19.91-1-lts

> journalctl -b | grep iwlwifi
Dec 26 13:19:58 jack-define kernel: iwlwifi 0000:17:00.0: loaded firmware version 38.755cfdd8.0 op_mode iwlmvm

No issues so far. If it continues to work I'm going to try this older firmware with the latest kernel and see if that also works.

Arch Linux

#1 2019-12-26 01:17:12

iwlwifi AC9260 Random Crashes CMD_DTS_MEASUREMENT_TRIGGER_WIDE

#2 2019-12-26 01:34:01

Re: iwlwifi AC9260 Random Crashes CMD_DTS_MEASUREMENT_TRIGGER_WIDE

#3 2019-12-26 08:58:09

Re: iwlwifi AC9260 Random Crashes CMD_DTS_MEASUREMENT_TRIGGER_WIDE

#4 2019-12-26 13:46:26

Re: iwlwifi AC9260 Random Crashes CMD_DTS_MEASUREMENT_TRIGGER_WIDE

Board footer