<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 TRANSITIONAL//EN">
<HTML>
<HEAD>
<META HTTP-EQUIV="Content-Type" CONTENT="text/html; CHARSET=UTF-8">
<META NAME="GENERATOR" CONTENT="GtkHTML/3.16.3">
</HEAD>
<BODY>
<FONT SIZE="4">I apologize in advance for what promises to be a lengthy post. Suggest heavy editing in any replies.</FONT><BR>
<BR>
<FONT SIZE="4">Since installing F11 on my Thinkpad W700 I've had a chronic problem with the wireless disconnecting after a random time interval. It was rock solid with F10. I've noticed a number of kernel errors in my e-mail logs. The most prolific example was yesterday:</FONT>
<BLOCKQUOTE>
<PRE>
<FONT SIZE="1">---------------------- Kernel Begin -----------------------</FONT>
<FONT SIZE="1">WARNING: Kernel Errors Present</FONT>
<FONT SIZE="1"> iwlagn: Error sending REPLY_SC ...: 1 Time(s)</FONT>
<FONT SIZE="1"> iwlagn: Error sending REPLY_TX ...: 5 Time(s)</FONT>
<FONT SIZE="1"> iwlagn: Error sending Sensitiv ...: 1 Time(s)</FONT>
<FONT SIZE="1"> iwlagn: Microcode SW error detected. Resta ...: 19 Time(s)</FONT>
<FONT SIZE="1">---------------------- Kernel End -------------------------</FONT>
</PRE>
</BLOCKQUOTE>
<FONT SIZE="4">I just now updated to the 2.6.29.6-217.2.7 kernel. --changelog says John Linville patched iwlwifi in the 217.2.5 kernel on Wednesday to fix a TX queue race. I pulled my eth0 cable, reset the NetworkManager wireless connection, and started a ping to my default gateway. The wifi connection lasted 11 pings, so John's patch didn't fix this problem.</FONT><BR>
<BR>
<FONT SIZE="4">When the ping stopped I saw the following in /var/log/messages:</FONT>
<BLOCKQUOTE>
<PRE>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: iwlagn: Microcode SW error detected. Restarting 0x82000000.</TT></FONT>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: iwlagn: No space for Tx</TT></FONT>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: iwlagn: Error sending SENSITIVITY_CMD failed</TT></FONT>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: iwlagn: SENSITIVITY_CMD failed: -28</TT></FONT>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: Registered led device: iwl-phy0:radio</TT></FONT>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: Registered led device; iwl-phy0:assoc</TT></FONT>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: Registered led device: iwl-phy0:RX</TT></FONT>
<FONT SIZE="1"><TT>Aug 16 15:57:10 tiger kernel: Registered led device: iwl-phy0:TX</TT></FONT>
</PRE>
</BLOCKQUOTE>
<FONT SIZE="4">When I click on the NetworkManager button to reset the wireless connection /var/log/messages reports a very chatty but normal looking restart:</FONT>
<BLOCKQUOTE>
<PRE>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> (wlan0): device state change: 8 -> 3 (reason 0)</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> (wlan0): deactivating device (reason: 0)</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <WARN> check_one_route(): (wlan0) error - 34 returned from rtnl_route_del(): Success#012</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger avahi-daemon[1901]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.7.</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger avahi-daemon[1901]: Interface wlan0.IPv4 no longer relevan for mDNS.</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0) starting connection 'Auto <SSID>'</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> (wlan0): device state change: 3 -> 4 (reason 0)</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> (wlan0): supplicant connection state: completed -> disconnected</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> (wlan0): device state change: 4 -> 5 (reason 0)</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0/wireless): connection 'Auto <SSID>' requires no security. No secrets needed.</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Config: added 'ssid' value '<SSID>'</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Config: added 'scan_ssid' value '1'</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Config: added 'key_mgmt' valuen 'NONE'</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> Config: set interface ap_scan to 1</FONT>
<FONT SIZE="1">Aug 16 16:03:46 tiger NetworkManager: <info> (wlan0: supplicant connection state: disconnected -> scanning</FONT>
<FONT SIZE="1">Aug 16 16:03:48 tiger ntpd[2263]: Deleting interface #10 wlan0, 192.168.1.7#123, interface stats: received=2, sent=18, dropped-0, active_time=664 secs</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> (wlan0): supplicant connection state: scanning -> associating</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> (wlan0): supplicant connection state: associating -> associated</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> (wlan0): supplicant connection state: associated -> completed</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network '<SSID>'.</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> (wlan0): device state change: 5 -> 7 (reason 0)</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> Activation (wlan0) Beginning DHCP transaction.</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> dhclient started with pid 4089</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info>Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: Internet Systems Consortium DHCP Client 4.1.0</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: Copyright 2004-2008 Internet Systems Consortium.</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: All rights reserved.</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: For info, please visit <A HREF="http://www.isc.org/sw.dhcp/">http://www.isc.org/sw.dhcp/</A></FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: </FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger NetworkManager: <info> DHCP: device wlan state changed normal exit -> preinit</FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: Listening on LPF/wlan0/<MAC></FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: Sending on LPF/wlan0/<MAC></FONT>
<FONT SIZE="1">Aug 16 16:03:49 tiger dhclient: Sending on Socket/fallback</FONT>
<FONT SIZE="1">Aug 16 16:03:50 tiger dhclient: DHCPREQUEST on wlan0 to 255.255.255.255 port 67</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger dhclient: DHCPREQUEST on wlan0 to 255.255.255.255 port 67</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger dhclient: DHCPACK from 192.168.1.2</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> DHCP: device wlan0 state changed preinit -> reboot</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP configure Get) scheduled...</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP Configure Get) started...</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> address 192.168.1.7</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> prefix 24 (255.255.255.0)</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> gateway 192.168.1.1</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> nameserver 'xxx.xxx.xxx.xxx'</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> nameserver 'yyy.yyy.yyy.yyy'</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> nameserver 'zzz.zzz.zzz.zzz'</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> domain name '<privatedomainname>'</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) scheduled...</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP Configure Get) complete.</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started...</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger avahi-daemon[1901]: Joining mDNS multicast group on interface wlan0.IPv4 with 192.168.1.7.</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger avahi-daemon[1901]: Registering new address record for 192.168.1.7 on wlan0.IPv4.</FONT>
<FONT SIZE="1">Aug 16 16:03:53 tiger dhclient: bound to 192.168.1.7 -- renewal in 2727 seconds.</FONT>
<FONT SIZE="1">Aug 16 16:03:54 tiger NetworkManager: <info> (wlan0): device state change: 7 -> 8 (reason 0)</FONT>
<FONT SIZE="1">Aug 16 16:03:54 tiger NetworkManager: <info> Policy set 'Auto <SSID>' (wlan0) as default for routing and DNS.</FONT>
<FONT SIZE="1">Aug 16 16:03:54 tiger NetworkManager: <info> Activation (wlan0) successful, device activated.</FONT>
<FONT SIZE="1">Aug 16 16:03:54 tiger NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete.</FONT>
<FONT SIZE="1">Aug 16 16:03:54 tiger ntpd02263]: Listening on interface #11 wlan0, 192.168.1.7#123 Enabled</FONT>
</PRE>
</BLOCKQUOTE>
<FONT SIZE="4">About a half hour later the connection failed with the same log entries:</FONT>
<BLOCKQUOTE>
<PRE>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: iwlagn: Microcode SW error detected. Restarting 0x82000000.</FONT>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: iwlagn: No space for Tx</FONT>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: iwlagn: Error sending Sensitivity_CMD: enqueue_hcmd failed: -28</FONT>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: iwlagn: SENSITIVITY_CMD failed</FONT>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: Registered led device: iwl-phy0:radio</FONT>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: Registered led device: iwl-phy0:assoc</FONT>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: Registered led device: iwl-phy0:RX</FONT>
<FONT SIZE="1">Aug 16 16:45:25 tiger kernel: Registered led device: iwl-phy0:TX</FONT>
</PRE>
</BLOCKQUOTE>
<FONT SIZE="4">Has anyone else running seen this misbehavior on a W700 running F11?</FONT><BR>
<BR>
<FONT SIZE="4">--Doc Savage</FONT><BR>
<FONT SIZE="4"> Fairview Heights, IL</FONT><BR>
<BR>
</BODY>
</HTML>