Unable to Connect Using WPA



Hello all.

I know there's been a lot of work going on in the wpa_supplicant area,
so I finally decided to give it a try as I would *really* love to
implement it into our network.

My testbed is on a WRTG54G using WPA Personal with TKIP and a plain
password.  When I try to connect, it just sits there and the logging
just stops.  The problem is, I don't know if this is a NM issue or in
WPA Supplicant.

I'm using NM 0.6.2 and WPASupplicant 0.4.8.  I attached my log to make
it easier to read.

Anyone have any ideas what I can do to get more information and/or how
to solve this?

Thanks!

-Mike
NetworkManager: <debug info>    [1144364185.834729] nm_device_802_11_wireless_get_activation_ap (): Forcing AP 'secure'
NetworkManager: <information>   User Switch: /org/freedesktop/NetworkManager/Devices/eth1 / secure
NetworkManager: <information>   Deactivating device eth1.
NetworkManager: <information>   Device eth1 activation scheduled...
NetworkManager: <information>   Activation (eth1) started...
NetworkManager: <information>   Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <information>   Activation (eth1) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <information>   Activation (eth1) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <information>   Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <information>   Activation (eth1) Stage 2 of 5 (Device Configure) starting...
NetworkManager: <information>   Activation (eth1/wireless): access point 'secure' is encrypted, and a key exists.  No new key needed.
NetworkManager: <information>   SUP: sending command 'INTERFACE_ADD eth1                wext    /var/run/wpa_supplicant '
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   SUP: sending command 'AP_SCAN 2'
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   SUP: sending command 'ADD_NETWORK'
NetworkManager: <information>   SUP: response was '0'
NetworkManager: <information>   SUP: sending command 'SET_NETWORK 0 ssid 736563757265'
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   SUP: sending command 'SET_NETWORK 0 scan_ssid 1'
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   SUP: sending command 'SET_NETWORK 0 proto WPA'
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   SUP: sending command 'SET_NETWORK 0 key_mgmt WPA-PSK'
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   SUP: sending command 'SET_NETWORK 0 psk <key>'
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   SUP: sending command 'ENABLE_NETWORK 0'
NetworkManager: <information>   SUP: response was 'OK'
NetworkManager: <information>   Activation (eth1) Stage 2 of 5 (Device Configure) complete.
NetworkManager: <information>   wpa_supplicant(30747): Global control interface '/var/run/wpa_supplicant-global'
NetworkManager: <information>   wpa_supplicant(30747): RX global ctrl_iface - hexdump_ascii(len=49):
NetworkManager: <information>   wpa_supplicant(30747):      49 4e 54 45 52 46 41 43 45 5f 41 44 44 20 65 74   INTERFACE_ADD et
NetworkManager: <information>   wpa_supplicant(30747):      68 31 09 09 77 65 78 74 09 2f 76 61 72 2f 72 75   h1__wext_/var/ru
NetworkManager: <information>   wpa_supplicant(30747):      6e 2f 77 70 61 5f 73 75 70 70 6c 69 63 61 6e 74   n/wpa_supplicant
NetworkManager: <information>   wpa_supplicant(30747):      09                                                _
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE GLOBAL INTERFACE_ADD 'eth1            wext    /var/run/wpa_supplicant '
NetworkManager: <information>   wpa_supplicant(30747): Initializing interface 'eth1' conf 'N/A' driver 'wext' ctrl_interface '/var/run/wpa_supplicant'
NetworkManager: <information>   wpa_supplicant(30747): Initializing interface (2) 'eth1'
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: SUPP_PAE entering state DISCONNECTED
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: KEY_RX entering state NO_KEY_RECEIVE
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: SUPP_BE entering state INITIALIZE
NetworkManager: <information>   wpa_supplicant(30747): EAP: EAP entering state DISABLED
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: External notification - portEnabled=0
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: External notification - portValid=0
NetworkManager: <information>   wpa_supplicant(30747): SIOCGIWRANGE: WE(compiled)=19 WE(source)=18 enc_capa=0xf
NetworkManager: <information>   wpa_supplicant(30747):   capabilities: key_mgmt 0xf enc 0xf
NetworkManager: <information>   wpa_supplicant(30747): Own MAC address: 00:13:ce:12:db:b1
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_set_wpa
NetworkManager: <information>   wpa_supplicant(30747): =0 key_idx=0 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_set_countermeasures
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_set_drop_unencrypted
NetworkManager: <information>   wpa_supplicant(30747): Setting scan request: 0 sec 100000 usec
NetworkManager: <information>   wpa_supplicant(30747): Added interface eth1
NetworkManager: <information>   wpa_supplicant(30747): Wireless event: cmd=0x8b06 len=8
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=9):
NetworkManager: <information>   wpa_supplicant(30747):      41 50 5f 53 43 41 4e 20 32                        AP_SCAN 2
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=11):
NetworkManager: <information>   wpa_supplicant(30747):      41 44 44 5f 4e 45 54 57 4f 52 4b                  ADD_NETWORK
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE: ADD_NETWORK
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=31):
NetworkManager: <information>   wpa_supplicant(30747):      53 45 54 5f 4e 45 54 57 4f 52 4b 20 30 20 73 73   SET_NETWORK 0 ss
NetworkManager: <information>   wpa_supplicant(30747):      69 64 20 37 33 36 35 36 33 37 35 37 32 36 35      id 736563757265
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE: SET_NETWORK id=0 name='ssid' value='736563757265'
NetworkManager: <information>   wpa_supplicant(30747): ssid - hexdump_ascii(len=6):
NetworkManager: <information>   wpa_supplicant(30747):      73 65 63 75 72 65                                 secure
NetworkManager: <information>   wpa_supplicant(30747):  - hexdump_ascii(len=25):
NetworkManager: <information>   wpa_supplicant(30747):      53 45 54 5f 4e 45 54 57 4f 52 4b 20 30 20 73 63   SET_NETWORK 0 sc
NetworkManager: <information>   wpa_supplicant(30747):      61 6e 5f 73 73 69 64 20 31                        an_ssid 1
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE: SET_NETWORK id=0 name='scan_ssid' value='1'
NetworkManager: <information>   wpa_supplicant(30747): scan_ssid=1 (0x1)
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=23):
NetworkManager: <information>   wpa_supplicant(30747):      53 45 54 5f 4e 45 54 57 4f 52 4b 20 30 20 70 72   SET_NETWORK 0 pr
NetworkManager: <information>   wpa_supplicant(30747):      6f 74 6f 20 57 50 41                              oto WPA
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE: SET_NETWORK id=0 name='proto' value='WPA'
NetworkManager: <information>   wpa_supplicant(30747): proto: 0x1
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=30):
NetworkManager: <information>   wpa_supplicant(30747):      53 45 54 5f 4e 45 54 57 4f 52 4b 20 30 20 6b 65   SET_NETWORK 0 ke
NetworkManager: <information>   wpa_supplicant(30747):      79 5f 6d 67 6d 74 20 57 50 41 2d 50 53 4b         y_mgmt WPA-PSK
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt' value='WPA-PSK'
NetworkManager: <information>   wpa_supplicant(30747): key_mgmt: 0x2
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=82): [REMOVED]
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE: SET_NETWORK id=0 name='psk' value='4c4475aa968f77cf892999ebe570613a477b40a66499911eaaab66788af4ca3f'
NetworkManager: <information>   wpa_supplicant(30747): PSK - hexdump(len=32): [REMOVED]
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=16):
NetworkManager: <information>   wpa_supplicant(30747): f 52 4b 20 30   ENABLE_NETWORK 0
NetworkManager: <information>   wpa_supplicant(30747): CTRL_IFACE: ENABLE_NETWORK id=0
NetworkManager: <information>   wpa_supplicant(30747): Setting scan request: 0 sec 0 usec
NetworkManager: <information>   wpa_supplicant(30747): State: DISCONNECTED -> SCANNING
NetworkManager: <information>   wpa_supplicant(30747): Trying to associate with SSID 'secure'
NetworkManager: <information>   wpa_supplicant(30747): Cancelling scan request
NetworkManager: <information>   wpa_supplicant(30747): WPA: clearing own WPA/RSN IE
NetworkManager: <information>   wpa_supplicant(30747): Automatic auth_alg selection: 0x1
NetworkManager: <information>   wpa_supplicant(30747): WPA: No WPA/RSN IE available from association info
NetworkManager: <information>   wpa_supplicant(30747): WPA: Set cipher suites based on configuration
NetworkManager: <information>   wpa_supplicant(30747): WPA: Selected cipher suites: group 30 pairwise 24 key_mgmt 2
NetworkManager: <information>   wpa_supplicant(30747): WPA: clearing AP WPA IE
NetworkManager: <information>   wpa_supplicant(30747): WPA: clearing AP RSN IE
NetworkManager: <information>   wpa_supplicant(30747): WPA: using GTK CCMP
NetworkManager: <information>   wpa_supplicant(30747): WPA: using PTK CCMP
NetworkManager: <information>   wpa_supplicant(30747): WPA: using KEY_MGMT WPA-PSK
NetworkManager: <information>   wpa_supplicant(30747): 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
NetworkManager: <information>   wpa_supplicant(30747): No keys have been configured - skip key clearing
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_set_drop_unencrypted
NetworkManager: <information>   wpa_supplicant(30747): State: SCANNING -> ASSOCIATING
NetworkManager: <information>   wpa_supplicant(30747): wpa_driver_wext_associate
NetworkManager: <information>   wpa_supplicant(30747): Setting authentication timeout: 60 sec 0 usec
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: External notification - EAP success=0
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: External notification - EAP fail=0
NetworkManager: <information>   wpa_supplicant(30747): EAPOL: External notification - portControl=Auto
NetworkManager: <information>   wpa_supplicant(30747): RX ctrl_iface - hexdump_ascii(len=6):
NetworkManager: <information>   eth1: link timed out.
NetworkManager: <information>   Old device 'eth1' activating, won't change.


[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]