FS#24110 - [kernel26] Microcode SW errors (iwl3945)

Attached to Project: Arch Linux
Opened by orbisvicis (orbisvicis) - Thursday, 05 May 2011, 10:38 GMT
Last edited by Eric Belanger (Snowman) - Saturday, 07 May 2011, 21:14 GMT
Task Type Bug Report
Category Packages: Extra
Status Closed
Assigned To Tobias Powalowski (tpowa)
Thomas Bächler (brain0)
Architecture All
Severity Medium
Priority Normal
Reported Version
Due in Version Undecided
Due Date Undecided
Percent Complete 100%
Votes 0
Private No

Details

Description:
As per dmesg every minute (on-the-dot) I receive this message, filtered with the following command:
$ dmesg | grep -i iwl | awk '{ a=$1; gsub(/\[|\]/,"",a); a=int(a); ah=int(a/60/60); a=(a-(ah*60*60)); am=int(a/60); a=(a-(am*60)); printf("%sh.%sm.%ss ",ah,am,a); for(i=2;i<=NF;i++){printf("%s ",$i)}; printf("\n")}'
12h.42m.51s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.42m.51s iwl3945 0000:0c:00.0: Loaded firmware version: 15.32.2.9
12h.42m.51s iwl3945 0000:0c:00.0: Start IWL Error Log Dump:
12h.42m.51s iwl3945 0000:0c:00.0: Status: 0x0002A2E4, count: 1
12h.42m.51s iwl3945 0000:0c:00.0: Desc Time asrtPC blink2 ilink1 nmiPC Line
12h.42m.51s iwl3945 0000:0c:00.0: SYSASSERT (0x5) 1793545710 0x008B6 0x13756 0x00320 0x00000 764
12h.42m.51s iwl3945 0000:0c:00.0: Start IWL Event Log Dump: display last 20 count
12h.42m.51s iwl3945 0000:0c:00.0: 1793544754 0x000005b6 1115
12h.42m.51s iwl3945 0000:0c:00.0: 1793544758 0x00000006 0463
12h.42m.51s iwl3945 0000:0c:00.0: 1793544759 0x00000006 0462
12h.42m.51s iwl3945 0000:0c:00.0: 1793544795 0x00000000 0201
12h.42m.51s iwl3945 0000:0c:00.0: 1793544805 0x0000001c 0206
12h.42m.51s iwl3945 0000:0c:00.0: 1793544807 0x00400001 0204
12h.42m.51s iwl3945 0000:0c:00.0: 1793544811 0x00400001 0219
12h.42m.51s iwl3945 0000:0c:00.0: 1793544812 0x00020041 0211
12h.42m.51s iwl3945 0000:0c:00.0: 1793544817 0x00000000 0212
12h.42m.51s iwl3945 0000:0c:00.0: 1793545148 0x00000000 0215
12h.42m.51s iwl3945 0000:0c:00.0: 1793545222 0x00400008 0220
12h.42m.51s iwl3945 0000:0c:00.0: 1793545239 0x00000000 0301
12h.42m.51s iwl3945 0000:0c:00.0: 1793545507 0x000000d4 0303
12h.42m.51s iwl3945 0000:0c:00.0: 1793545671 0x443c0080 0401
12h.42m.51s iwl3945 0000:0c:00.0: 1793545685 0x0000000d 0452
12h.42m.51s iwl3945 0000:0c:00.0: 1793545689 0x00113b6e 0450
12h.42m.51s iwl3945 0000:0c:00.0: 1793545695 0x00113b6e 0450
12h.42m.51s iwl3945 0000:0c:00.0: 1793545700 0x00133b6e 0450
12h.42m.51s iwl3945 0000:0c:00.0: 1793545706 0x00133b6e 0450
12h.42m.51s iwl3945 0000:0c:00.0: 1793545711 0x00000100 0125
12h.42m.51s iwl3945 0000:0c:00.0: Error Reply type 0x000002FC cmd REPLY_SCAN_CMD (0x80) seq 0x443C ser 0x00340000
12h.42m.51s iwl3945 0000:0c:00.0: Can't stop Rx DMA.

The most interesting thing thing is the frequency of this message; it is flooding my logs:
$ dmesg | grep -i iwl | awk '{ a=$1; gsub(/\[|\]/,"",a); a=int(a); ah=int(a/60/60); a=(a-(ah*60*60)); am=int(a/60); a=(a-(am*60)); printf("%sh.%sm.%ss ",ah,am,a); for(i=2;i<=NF;i++){printf("%s ",$i)}; printf("\n")}' | awk '{if(prev!=$1){print $0}; prev=$1}'
...
12h.24m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.25m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.26m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.27m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.28m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.29m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.30m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.31m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.32m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.33m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.34m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.35m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.36m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.37m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.38m.50s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.39m.51s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.40m.31s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.41m.31s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.42m.51s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.
12h.44m.31s iwl3945 0000:0c:00.0: Microcode SW error detected. Restarting 0x82000008.

While this problem isn't affecting my short-term ability to maintain a wireless connection, I think it is severely degrading performance. And every-now-and then the wireless connection is dropped (30min...60min..90min..)

Additional info:
* package version(s)
kernel26-headers 2.6.38.5-1

$ modinfo iwl3945
...
firmware: iwlwifi-3945-2.ucode
...
version: in-tree:s
...

$ uname -a
Linux 2.6.38-ARCH #1 SMP PREEMPT i686 Intel CPU T2400 @ 1.83GHz
$ lspci | grep -i 394
0c:00.0 Network controller: Intel Corporation PRO/Wireless 3945ABG [Golan] Network Connection (rev 02)
This task depends upon

Closed by  Eric Belanger (Snowman)
Saturday, 07 May 2011, 21:14 GMT
Reason for closing:  Not a bug
Comment by orbisvicis (orbisvicis) - Saturday, 07 May 2011, 14:12 GMT
Seems to have been a one-time occurrence. I haven't been able to duplicate it upon reboots or upon other network configurations.
--> Can be closed

Loading...