problem with iwlwifi

Amit Rana amit.rana at gmail.com
Wed May 2 08:29:06 UTC 2007 

Hi,
 I was finally able to start my wifi, but soon after my first internet
request i.e. ping google.com it stopped responding. It did give result
for the first ping but there after it didnt work with constant
recursive messages in /var/log/messages

[amit at localhost ~]$ uname -ar
Linux localhost.localdomain 2.6.21-1.3116.fc7 #1 SMP Thu Apr 26
10:36:44 EDT 2007 i686 i686 i386 GNU/Linux

http://smolt.fedoraproject.org/show?UUID=22c8710a-e702-4bcb-b002-448a3e53805b

messages:
May  2 13:46:30 localhost NetworkManager: <info>  Updating allowed
wireless network lists.
May  2 13:46:31 localhost NetworkManager: <info>  SWITCH: no current
connection, found better connection 'wlan0'.
May  2 13:46:31 localhost dhcdbd: message_handler: message handler not
found under /com/redhat/dhcp/wlan0 for sub-path wlan0.dbus.get.reason
May  2 13:46:32 localhost NetworkManager: <info>  Will activate
connection 'wlan0/TJNET'.
May  2 13:46:32 localhost NetworkManager: <info>  Device wlan0
activation scheduled...
May  2 13:46:32 localhost NetworkManager: <info>  Activation (wlan0) started...
May  2 13:46:33 localhost NetworkManager: <info>  Activation (wlan0)
Stage 1 of 5 (Device Prepare) scheduled...
May  2 13:46:33 localhost NetworkManager: <info>  Activation (wlan0)
Stage 1 of 5 (Device Prepare) started...
May  2 13:46:33 localhost NetworkManager: <info>  Activation (wlan0)
Stage 2 of 5 (Device Configure) scheduled...
May  2 13:46:34 localhost NetworkManager: <info>  Activation (wlan0)
Stage 1 of 5 (Device Prepare) complete.
May  2 13:46:35 localhost NetworkManager: <info>  Activation (wlan0)
Stage 2 of 5 (Device Configure) starting...
May  2 13:46:35 localhost NetworkManager: <info>  Activation
(wlan0/wireless): access point 'TJNET' is encrypted, but NO valid key
exists.  New key needed.
May  2 13:46:35 localhost NetworkManager: <info>  Activation (wlan0)
New wireless user key requested for network 'TJNET'.
May  2 13:46:35 localhost NetworkManager: <info>  Activation (wlan0)
Stage 2 of 5 (Device Configure) complete.
May  2 13:46:36 localhost NetworkManager: <info>  Activation (wlan0)
New wireless user key for network 'TJNET' received.
May  2 13:46:36 localhost NetworkManager: <info>  Activation (wlan0)
Stage 1 of 5 (Device Prepare) scheduled...
May  2 13:46:36 localhost NetworkManager: <info>  Activation (wlan0)
Stage 1 of 5 (Device Prepare) started...
May  2 13:46:36 localhost NetworkManager: <info>  Activation (wlan0)
Stage 2 of 5 (Device Configure) scheduled...
May  2 13:46:36 localhost NetworkManager: <info>  Activation (wlan0)
Stage 1 of 5 (Device Prepare) complete.
May  2 13:46:36 localhost NetworkManager: <info>  Activation (wlan0)
Stage 2 of 5 (Device Configure) starting...
May  2 13:46:36 localhost NetworkManager: <info>  Activation
(wlan0/wireless): access point 'TJNET' is encrypted, and a key exists.
 No new key needed.
May  2 13:46:36 localhost NetworkManager: <info>  SUP: sending command
'INTERFACE_ADD wlan0		wext	/var/run/wpa_supplicant	'
May  2 13:46:36 localhost yum-updatesd: error getting update info:
Cannot open/read repomd.xml file for repository: development
May  2 13:46:36 localhost setroubleshoot: [rpc.ERROR] attempt to open
server connection failed: (2, 'No such file or directory')
May  2 13:46:36 localhost NetworkManager: <info>  SUP: response was 'OK'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: sending command
'AP_SCAN 1'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: response was 'OK'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: sending command
'ADD_NETWORK'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: response was '0'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: sending command
'SET_NETWORK 0 ssid 544a4e4554'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: response was 'OK'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: sending command
'SET_NETWORK 0 key_mgmt NONE'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: response was 'OK'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: sending command
'SET_NETWORK 0 wep_key0 <key>'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: response was 'OK'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: sending command
'SET_NETWORK 0 wep_tx_keyidx 0'
May  2 13:46:36 localhost NetworkManager: <info>  SUP: response was 'OK'
May  2 13:46:37 localhost NetworkManager: <info>  SUP: sending command
'ENABLE_NETWORK 0'
May  2 13:46:37 localhost NetworkManager: <info>  SUP: response was 'OK'
May  2 13:46:37 localhost NetworkManager: <info>  Activation (wlan0)
Stage 2 of 5 (Device Configure) complete.
May  2 13:46:37 localhost kernel: iwlwifi: TODO: Look into long/short
preamble change handling.
May  2 13:46:37 localhost last message repeated 4 times
May  2 13:46:38 localhost bonobo-activation-server (amit-3903):
Passing command-line arguments in .server files is deprecated:
"/usr/bin/tomboy --panel-applet"
May  2 13:46:38 localhost wpa_supplicant[4010]: Trying to associate
with 00:15:e9:02:ac:38 (SSID='TJNET' freq=2437 MHz)
May  2 13:46:38 localhost kernel: hwcrypto disabled!
May  2 13:46:38 localhost kernel: iwlwifi: TODO: Look into long/short
preamble change handling.
May  2 13:46:38 localhost wpa_supplicant[4010]: Associated with
00:15:e9:02:ac:38
May  2 13:46:38 localhost wpa_supplicant[4010]: CTRL-EVENT-CONNECTED -
Connection to 00:15:e9:02:ac:38 completed (auth) [id=0 id_str=]
May  2 13:46:38 localhost NetworkManager: <info>  Activation
(wlan0/wireless) Stage 2 of 5 (Device Configure) successful.
Connected to access point 'TJNET'.
May  2 13:46:38 localhost kernel: iwlwifi: REPLY_ADD_STA failed
May  2 13:46:38 localhost kernel: iwlwifi: Network RSSI: -52
May  2 13:46:38 localhost NetworkManager: <info>  Activation (wlan0)
Stage 3 of 5 (IP Configure Start) scheduled.
May  2 13:46:38 localhost NetworkManager: <info>  Activation (wlan0)
Stage 3 of 5 (IP Configure Start) started...
May  2 13:46:39 localhost NetworkManager: <info>  Activation (wlan0)
Beginning DHCP transaction.
May  2 13:46:39 localhost NetworkManager: <info>  Activation (wlan0)
Stage 3 of 5 (IP Configure Start) complete.
May  2 13:46:39 localhost NetworkManager: <info>  DHCP daemon state is
now 12 (successfully started) for interface wlan0
May  2 13:46:39 localhost dhclient: wmaster0: unknown hardware address type 801
May  2 13:46:39 localhost NetworkManager: <info>  DHCP daemon state is
now 1 (starting) for interface wlan0
May  2 13:46:39 localhost dhclient: wmaster0: unknown hardware address type 801
May  2 13:46:39 localhost dhclient: DHCPDISCOVER on wlan0 to
255.255.255.255 port 67 interval 7
May  2 13:46:39 localhost dhclient: DHCPOFFER from 192.168.0.1
May  2 13:46:39 localhost dhclient: DHCPREQUEST on wlan0 to
255.255.255.255 port 67
May  2 13:46:39 localhost dhclient: DHCPACK from 192.168.0.1
May  2 13:46:39 localhost NetworkManager: <info>  DHCP daemon state is
now 2 (bound) for interface wlan0
May  2 13:46:39 localhost NetworkManager: <info>  Activation (wlan0)
Stage 4 of 5 (IP Configure Get) scheduled...
May  2 13:46:39 localhost NetworkManager: <info>  Activation (wlan0)
Stage 4 of 5 (IP Configure Get) started...
May  2 13:46:39 localhost dhcdbd: message_handler: message handler not
found under /com/redhat/dhcp/wlan0 for sub-path
wlan0.dbus.get.host_name
May  2 13:46:39 localhost dhcdbd: message_handler: message handler not
found under /com/redhat/dhcp/wlan0 for sub-path
wlan0.dbus.get.domain_name
May  2 13:46:39 localhost dhcdbd: message_handler: message handler not
found under /com/redhat/dhcp/wlan0 for sub-path
wlan0.dbus.get.nis_domain
May  2 13:46:39 localhost dhcdbd: message_handler: message handler not
found under /com/redhat/dhcp/wlan0 for sub-path
wlan0.dbus.get.nis_servers
May  2 13:46:39 localhost NetworkManager: <info>  Retrieved the
following IP4 configuration from the DHCP daemon:
May  2 13:46:39 localhost NetworkManager: <info>    address 192.168.0.113
May  2 13:46:39 localhost NetworkManager: <info>    netmask 255.255.255.0
May  2 13:46:39 localhost NetworkManager: <info>    broadcast 192.168.0.255
May  2 13:46:39 localhost NetworkManager: <info>    gateway 192.168.0.1
May  2 13:46:39 localhost NetworkManager: <info>    nameserver 208.67.222.222
May  2 13:46:39 localhost NetworkManager: <info>    nameserver 192.168.0.1
May  2 13:46:39 localhost NetworkManager: <info>  Activation (wlan0)
Stage 5 of 5 (IP Configure Commit) scheduled...
May  2 13:46:39 localhost NetworkManager: <info>  Activation (wlan0)
Stage 4 of 5 (IP Configure Get) complete.
May  2 13:46:39 localhost dhclient: bound to 192.168.0.113 -- renewal
in 595395 seconds.
May  2 13:46:39 localhost NetworkManager: <info>  Activation (wlan0)
Stage 5 of 5 (IP Configure Commit) started...
May  2 13:46:39 localhost avahi-daemon[2752]: Joining mDNS multicast
group on interface wlan0.IPv4 with address 192.168.0.113.
May  2 13:46:39 localhost avahi-daemon[2752]: New relevant interface
wlan0.IPv4 for mDNS.
May  2 13:46:39 localhost avahi-daemon[2752]: Registering new address
record for 192.168.0.113 on wlan0.IPv4.
May  2 13:46:40 localhost NetworkManager: <info>  Activation (wlan0)
successful, device activated.
May  2 13:46:40 localhost NetworkManager: <info>  Activation (wlan0)
Finish handler scheduled.
May  2 13:46:40 localhost NetworkManager: <info>  Activation (wlan0)
Stage 5 of 5 (IP Configure Commit) complete.
May  2 13:46:53 localhost kernel: iwlwifi: TODO: Look into long/short
preamble change handling.
May  2 13:46:53 localhost last message repeated 3 times
May  2 13:46:55 localhost kernel: BUG: warning at
include/asm/dma-mapping.h:25/dma_map_single() (Not tainted)
May  2 13:46:55 localhost kernel:  [<c04061e9>] show_trace_log_lvl+0x1a/0x2f
May  2 13:46:55 localhost kernel:  [<c04067ad>] show_trace+0x12/0x14
May  2 13:46:55 localhost kernel:  [<c0406831>] dump_stack+0x16/0x18
May  2 13:46:55 localhost kernel:  [<f8b03708>] d_tx+0x7f2/0xd69 [iwlwifi]
May  2 13:46:55 localhost kernel:  [<f8ac1759>]
__ieee80211_tx+0x20/0xec [mac80211]
May  2 13:46:55 localhost kernel:  [<f8ac361b>]
ieee80211_master_start_xmit+0x410/0x50e [mac80211]
May  2 13:46:55 localhost kernel:  [<c05b41b2>] dev_hard_start_xmit+0x1ce/0x22b
May  2 13:46:55 localhost kernel:  [<c05c1cee>] __qdisc_run+0xdb/0x195
May  2 13:46:55 localhost kernel:  [<c05b4ee5>] net_tx_action+0xc2/0xeb
May  2 13:46:55 localhost kernel:  [<c042bfa7>] __do_softirq+0x6f/0xe2
May  2 13:46:55 localhost kernel:  [<c0407420>] do_softirq+0x61/0xd0
May  2 13:46:55 localhost kernel:  [<c042bdd2>] local_bh_enable_ip+0xb9/0xdf
May  2 13:46:55 localhost kernel:  [<c06160bd>] _spin_unlock_bh+0x25/0x28
May  2 13:46:55 localhost kernel:  [<f8acfc9e>]
ieee80211_scan_completed+0xdf/0x109 [mac80211]
May  2 13:46:55 localhost kernel:  [<f8ad10ef>]
ieee80211_sta_scan_work+0x63/0x199 [mac80211]
May  2 13:46:55 localhost kernel:  [<c043510f>] run_workqueue+0x89/0x14e
May  2 13:46:55 localhost kernel:  [<c0435b25>] worker_thread+0xf8/0x124
May  2 13:46:55 localhost kernel:  [<c043832b>] kthread+0xb3/0xdc
May  2 13:46:55 localhost kernel:  [<c0405cd3>] kernel_thread_helper+0x7/0x10
May  2 13:46:55 localhost kernel:  =======================
May  2 13:46:58 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:46:58 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:46:59 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:46:59 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:46:59 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:00 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:00 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:00 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:01 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:01 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:01 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:01 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:02 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:02 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:02 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:02 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:03 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:03 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:03 localhost kernel: iwlwifi: Error sending RXON_ASSOC:
time out after 500ms.
May  2 13:47:03 localhost kernel: iwlwifi: Error setting non-tune
configuration (-110).
May  2 13:47:04 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:04 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:05 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:05 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:05 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:05 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:06 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:06 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:06 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:06 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:07 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:07 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:07 localhost kernel: iwlwifi: Error sending RXON: time
out after 500ms.
May  2 13:47:07 localhost kernel: iwlwifi: Error clearing ASSOC_MSK on
current configuration (-110).
May  2 13:47:08 localhost kernel: iwlwifi: Error sending RXON_ASSOC:
time out after 500ms.
May  2 13:47:08 localhost kernel: iwlwifi: Error setting non-tune
configuration (-110).

last 30-40 messages starting from
May  2 13:46:55 localhost kernel: BUG: warning at
include/asm/dma-mapping.h:25/dma_map_single() (Not tainted)
kept on repeating.

And I cannot use wifi.

How do I reset the connection? If I use NM to disable and then enable
it never re-enables, I have to restart.

any help?

More information about the test mailing list