Re: Flaky association with ipw2200 and Linksys WRT54G

From: Christian Schneider <christian daftdog de>
To: networkmanager-list gnome org
Subject: Re: Flaky association with ipw2200 and Linksys WRT54G
Date: Fri, 05 May 2006 18:20:50 +0200
Hey again, this is the output of /var/log/messages during a failed try
after unplugging eth0 and clicking on my AP (I was asked to enter the
wpa key and entered the correct one during the procedure):

May  5 18:03:39 localhost NetworkManager: <information> User
Switch: /org/freedesktop/NetworkManager/Devices/eth1 / DaftDog
May  5 18:03:39 localhost NetworkManager: <information> Deactivating
device eth1.
May  5 18:03:41 localhost NetworkManager: <information> Device eth1
activation scheduled...
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) started...
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) Stage 1 of 5 (Device Prepare) scheduled...
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) Stage 1 of 5 (Device Prepare) started...
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) Stage 2 of 5 (Device Configure) scheduled...
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) Stage 1 of 5 (Device Prepare) complete.
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) Stage 2 of 5 (Device Configure) starting...
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1/wireless): access point 'DaftDog' is encrypted, but NO valid key
exists.  New key needed.
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) New wireless user key requested for network 'DaftDog'.
May  5 18:03:41 localhost NetworkManager: <information> Activation
(eth1) Stage 2 of 5 (Device Configure) complete.
May  5 18:03:49 localhost NetworkManager: <information> Activation
(eth1) New wireless user key for network 'DaftDog' received.
May  5 18:03:49 localhost NetworkManager: <information> Activation
(eth1) Stage 1 of 5 (Device Prepare) scheduled...
May  5 18:03:49 localhost NetworkManager: <information> Activation
(eth1) Stage 1 of 5 (Device Prepare) started...
May  5 18:03:49 localhost NetworkManager: <information> Activation
(eth1) Stage 2 of 5 (Device Configure) scheduled...
May  5 18:03:49 localhost NetworkManager: <information> Activation
(eth1) Stage 1 of 5 (Device Prepare) complete.
May  5 18:03:49 localhost NetworkManager: <information> Activation
(eth1) Stage 2 of 5 (Device Configure) starting...
May  5 18:03:49 localhost NetworkManager: <information> Activation
(eth1/wireless): access point 'DaftDog' is encrypted, and a key exists.
No new key needed.
May  5 18:03:50 localhost NetworkManager: <information> SUP: sending
command 'INTERFACE_ADD eth1
wext    /var/run/wpa_supplicant '
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was 'OK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: sending
command 'AP_SCAN 1'
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was 'OK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: sending
command 'ADD_NETWORK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was '0'
May  5 18:03:51 localhost NetworkManager: <information> SUP: sending
command 'SET_NETWORK 0 ssid 44616674446f67'
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was 'OK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: sending
command 'SET_NETWORK 0 proto WPA'
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was 'OK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: sending
command 'SET_NETWORK 0 key_mgmt WPA-PSK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was 'OK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: sending
command 'SET_NETWORK 0 psk <key>'
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was 'OK'
May  5 18:03:51 localhost NetworkManager: <information> SUP: sending
command 'ENABLE_NETWORK 0'
May  5 18:03:51 localhost NetworkManager: <information> SUP: response
was 'OK'
May  5 18:03:51 localhost NetworkManager: <information> Activation
(eth1) Stage 2 of 5 (Device Configure) complete.
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): Global control interface
'/var/run/wpa_supplicant-global'
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): RX global ctrl_iface - hexdump_ascii(len=49):
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      49 4e 54 45 52 46 41 43 45 5f 41 44 44 20 65
74   INTERFACE_ADD et
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      68 31 09 09 77 65 78 74 09 2f 76 61 72 2f 72
75   h1__wext_/var/ru
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      6e 2f 77 70 61 5f 73 75 70 70 6c 69 63 61 6e
74   n/wpa_supplicant
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      09
_
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE GLOBAL INTERFACE_ADD 'eth1
wext    /var/run/wpa_supplicant      '
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): Initializing interface 'eth1' conf 'N/A' driver
'wext' ctrl_interface '/var/run/wpa_supplicant'
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): Initializing interface (2) 'eth1'
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: SUPP_PAE entering state DISCONNECTED
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: KEY_RX entering state NO_KEY_RECEIVE
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: SUPP_BE entering state INITIALIZE
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): EAP: EAP entering state DISABLED
May  5 18:03:51 localhost kernel: ADDRCONF(NETDEV_CHANGE): eth1: link
becomes ready
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portEnabled=0
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portValid=0
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): SIOCGIWRANGE: WE(compiled)=19 WE(source)=18
enc_capa=0xf
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):   capabilities: key_mgmt 0xf enc 0xf
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): Own MAC address: 00:0c:f1:24:3b:de
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_wpa
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): =0 key_idx=0 set_tx=0 seq_len=0 key_len=0
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0
seq_len=0 key_len=0
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0
seq_len=0 key_len=0
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0
seq_len=0 key_len=0
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_countermeasures
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_drop_unencrypted
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): Setting scan request: 0 sec 100000 usec
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): Added interface eth1
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): Wireless event: cmd=0x8b06 len=8
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): RX ctrl_iface - hexdump_ascii(len=9):
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      41 50 5f 53 43 41 4e 20 31
AP_SCAN 1
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): RX ctrl_iface - hexdump_ascii(len=11):
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      41 44 44 5f 4e 45 54 57 4f 52 4b
ADD_NETWORK
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE: ADD_NETWORK
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): RX ctrl_iface - hexdump_ascii(len=33):
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      53 45 54 5f 4e 45 54 57 4f 52 4b 20 30 20 73
73   SET_NETWORK 0 ss
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      69 64 20 34 34 36 31 36 36 37 34 34 34 36 66
36   id 44616674446f6
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      37
7
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE: SET_NETWORK id=0 name='ssid'
value='44616674446f67'
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): ssid - hexdump_ascii(len=7):
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): 66 74 44 6f 67
DaftDog
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): RX ctrl_iface - hexdump_ascii(len=23):
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      53 45 54 5f 4e 45 54 57 4f 52 4b 20 30 20 70
72   SET_NETWORK 0 pr
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      6f 74 6f 20 57 50 41
oto WPA
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE: SET_NETWORK id=0 name='proto'
value='WPA'
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): proto: 0x1
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756): RX ctrl_iface - hexdump_ascii(len=30):
May  5 18:03:51 localhost NetworkManager: <information>
wpa_supplicant(3756):      53 45 54 5f 4e 45 54 57 4f 52 4b 20 30 20 6b
65   SET_NETWORK 0 ke
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756):      79 5f 6d 67 6d 74 20 57 50 41 2d 50 53 4b
y_mgmt WPA-PSK
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
value='WPA-PSK'
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): key_mgmt: 0x2
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): RX ctrl_iface - hexdump_ascii(len=82): [REMOVED]
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE: SET_NETWORK id=0 name='psk'
value='f0648c588286cb5b4b662288806b3772ce4a3e0da3a31b22a0d89fc494f94ac3'
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): PSK - hexdump(len=32): [REMOVED]
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): RX ctrl_iface - hexdump_ascii(len=16):
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756):      45 4e 41 42 4c 45 5f 4e 45 54 57 4f 52 4b 20
30   ENABLE_NETWORK 0
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE: ENABLE_NETWORK id=0
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): Setting scan request: 0 sec 0 usec
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): State: DISCONNECTED -> SCANNING
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): Starting AP scan (broadcast SSID)
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): exdump_ascii(len=6):
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756):      41 54 54 41 43 48
ATTACH
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE monitor attached - hexdump(len=42): 2f
76 61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61 6e 61 67 65 72 2f 77
70 61 5f 63 74 72 6c 5f 32 31 37 32 2d 39 00 00 00
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): Wireless event: cmd=0x8b15 len=20
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): Wireless event: new AP: 00:13:49:10:c2:a1
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): State: SCANNING -> ASSOCIATED
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): Associated to a new BSS: BSSID=00:13:49:10:c2:a1
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): No keys have been configured - skip key clearing
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): Network configuration found for the current AP
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: No WPA/RSN IE available from association info
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: Set cipher suites based on configuration
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: Selected cipher suites: group 30 pairwise 24
key_mgmt 2
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: clearing AP WPA IE
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: clearing AP RSN IE
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: using GTK CCMP
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: using PTK CCMP
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: using KEY_MGMT WPA-PSK
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: Set own WPA IE default - hexdump(len=24): dd
16 00 50 f2 01 01 00 00 50 f2 04 01 00 00 50 f2 04 01 00 00 50 f2 02
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - EAP success=0
May  5 18:03:52 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - EAP fail=0
May  5 18:04:02 localhost NetworkManager: <information> eth1: link timed
out.
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756):  portControl=Auto
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Associated with 00:13:49:10:c2:a1
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE monitor send - hexdump(len=42): 2f 76
61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61 6e 61 67 65 72 2f 77 70
61 5f 63 74 72 6c 5f 32 31 37 32 2d 39 00 00 00
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: Association event - clear replay counter
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portEnabled=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portValid=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - EAP success=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portEnabled=1
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: SUPP_PAE entering state CONNECTING
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: SUPP_BE entering state IDLE
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Setting authentication timeout: 10 sec 0 usec
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): RTM_NEWLINK, IFLA_IFNAME: Interface 'eth1' added
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): RX EAPOL from 00:13:49:10:c2:a1
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): RX EAPOL - hexdump(len=99): 01 03 00 5f fe 00 89
00 20 00 00 00 00 00 00 00 01 24 ae 5b 70 2d b2 eb aa 25 f9 35 65 29 6f
8f e4 e6 6b 55 70 c8 ff ce 97 de 09 2e 63 70 50 8d d3 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Setting authentication timeout: 10 sec 0 usec
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): E 802.1X RX: version=1 type=3 length=95
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756):   EAPOL-Key type=254
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: RX EAPOL-Key - hexdump(len=99): 01 03 00 5f
fe 00 89 00 20 00 00 00 00 00 00 00 01 24 ae 5b 70 2d b2 eb aa 25 f9 35
65 29 6f 8f e4 e6 6b 55 70 c8 ff ce 97 de 09 2e 63 70 50 8d d3 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: CCMP is used, but EAPOL-Key descriptor
version (1) is not 2.
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: startWhen --> 0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: SUPP_PAE entering state CONNECTING
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: txStart
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: drop TX EAPOL in non-IEEE 802.1X mode (type=1
len=0)
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Scan timeout - try to get results
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Received 851 bytes of scan results (4 BSSes)
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Scan results: 4
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Selecting BSS from priority group 0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): 0: 00:13:49:10:c2:a1 ssid='DaftDog' wpa_ie_len=24
rsn_ie_len=0 caps=0x11
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756):    selected based on WPA IE
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Trying to associate with 00:13:49:10:c2:a1
(SSID='DaftDog' freq=0 MHz)
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): 61 5f 63 74 72 6c 5f 32 31 37 32 2d 39 00 00 00
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Cancelling scan request
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: clearing own WPA/RSN IE
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Automatic auth_alg selection: 0x1
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: using IEEE 802.11i/D3.0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: Selected cipher suites: group 8 pairwise 8
key_mgmt 2
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: set AP WPA IE - hexdump(len=24): dd 16 00 50
f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: clearing AP RSN IE
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: using GTK TKIP
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: using PTK TKIP
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: using KEY_MGMT WPA-PSK
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): WPA: Set own WPA IE default - hexdump(len=24): dd
16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): No keys have been configured - skip key clearing
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_drop_unencrypted
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): State: ASSOCIATED -> ASSOCIATING
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_associate
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Setting authentication timeout: 15 sec 0 usec
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - EAP success=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - EAP fail=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portControl=Auto
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Wireless event: cmd=0x8b06 len=8
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Wireless event: cmd=0x8b15 len=20
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Wireless event: new AP: 00:00:00:00:00:00
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756):
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): State: ASSOCIATING -> DISCONNECTED
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portEnabled=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: SUPP_PAE entering state DISCONNECTED
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: SUPP_BE entering state INITIALIZE
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - portValid=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): EAPOL: External notification - EAP success=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL-EVENT-DISCONNECTED - Disconnect event -
remove keys
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): CTRL_IFACE monitor send - hexdump(len=42): 2f 76
61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61 6e 61 67 65 72 2f 77 70
61 5f 63 74 72 6c 5f 32 31 37 32 2d 39 00 00 00
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0
seq_len=0 key_len=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0
seq_len=0 key_len=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0
seq_len=0 key_len=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0
seq_len=0 key_len=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0
seq_len=0 key_len=0
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): RTM_NEWLINK, IFLA_IFNAME: Interface 'eth1' added
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Wireless event: cmd=0x8b1a len=16
May  5 18:04:09 localhost NetworkManager: <information>
wpa_supplicant(3756): Authentication with 00:00:00:00:00:00 timed out.
May  5 18:04:11 localhost NetworkManager: <information> Activation
(eth1/wireless): association took too long (>20s), failing activation.
May  5 18:04:11 localhost NetworkManager: <information> Activation
(eth1) failure scheduled...
May  5 18:04:11 localhost NetworkManager: <information> Activation
(eth1) failed for access point (DaftDog)
May  5 18:04:11 localhost NetworkManager: <information> Activation
(eth1) failed.
May  5 18:04:11 localhost NetworkManager: <information> Deactivating
device eth1.


I'm using FC5 with the newest kernel (2.6.16-1.2096) and firmware 1.3-2
for ipw2100.



On Fri, 2006-05-05 at 11:14 -0400, Dan Williams wrote:
> On Fri, 2006-05-05 at 16:32 +0200, Christian Schneider wrote:
> > Hey,
> > I have a similar problem with the ipw2100 wlan chip and driver under
> > FC5. The very first time after installation things worked, but after
> > that (reboot, plug- and unplug wired lan) it only works occasionally
> > after a reboot (very seldomly though).
> > Is the problem related to the ipw2200 problem? I'm not exactly a
noob,
> > but totally new to Fedora (comming from Gentoo), even finding
> > kernel-sources is still a big challenge for me (why do things have
to be
> > so different in every distro?).
> 
> What does /var/log/messages say under these circumstances?  I've got
an
> ipw2100 in my laptop that I do  most of my NM development on, and
that's
> been fairly solid for quite a while.  I also have a WRT54G at home.
> Note that ipw2100 and ipw2200 use the same in-kernel ieee80211 stack,
so
> some driver bugs that affect one will affect the other.
> 
> dan
> 
>
[Date Prev][Date Next] [Thread Prev][Thread Next] [Thread Index] [Date Index] [Author Index]