Re: trigger manual connection && problems assertion with WPA-EAP network

[Ryan Novosielski <novosirj umdnj edu>]

-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1

Ralf Rublack wrote:
> hi guys
> 
> at first, why is a active connection restartet if I click in mn-applet
> on this network. is there any reason for this behavior?
> 
> second, i had lately some problems to connect to a network with
> configuration
> 	key_mgmt=WPA-EAP
>         eap=TTLS
>         proto=WPA
>         pairwise=TKIP
>         group=WEP104
>         phase2="auth=PAP"
> 
> I connected to this network many times without any problem,
> so the anonymous_identity, identity and password are in gconf (why
> password not in keyring).
> 
> this morning after return from hibernation (befor i was connected to
> another wireless), when i tried to connect it got the question for a new
> password.
> here the output in syslog
> 
> Jan 24 11:13:59 popalf NetworkManager: <info>  Will activate connection
> 'ath0/802.1X'. 
> Jan 24 11:13:59 popalf NetworkManager: <info>  Device
> ath0 activation scheduled... 
> Jan 24 11:13:59 popalf NetworkManager:<info>  Activation (ath0)
> started... 
> Jan 24 11:13:59 popalf NetworkManager: <info>  Activation (ath0) Stage
> 1 of 5 (Device Prepare) scheduled... 
> Jan 24 11:13:59 popalf NetworkManager: <info>  Activation
> (ath0) Stage 1 of 5 (Device Prepare) started... 
> Jan 24 11:13:59 popalf NetworkManager: <info>  Activation (ath0) Stage
> 2 of 5 (Device Configure) scheduled... 
> Jan 24 11:13:59 popalf NetworkManager: <info> Activation (ath0) Stage 1
> of 5 (Device Prepare) complete. 
> Jan 24 11:13:59 popalf NetworkManager:<info>  Activation (ath0) Stage 2
> of 5 (Device Configure) starting... 
> Jan 24 11:13:59 popalf NetworkManager: <info>  Activation
> (ath0/wireless): access point '802.1X' is encrypted, and a key exists.
> No new key needed. 
> Jan 24 11:14:00 popalf NetworkManager: <info>
> supplicant_interface_init() - connect to global ctrl socket (0/10). 
> Jan
> 24 11:14:01 popalf NetworkManager: <info> supplicant_interface_init() -
> connect to global ctrl socket (1/10).
> Jan 24 11:14:01 popalf NetworkManager: <info>
> supplicant_interface_init() - connect to global ctrl socket (2/10). 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'INTERFACE_ADD ath0^I^Imadwifi^I/var/run/wpa_supplicant2^I'
> Jan 24 11:14:01 popalf kernel: [19625.112000] ADDRCONF(NETDEV_CHANGE):
> ath0: link becomes ready 
> Jan 24 11:14:01 popalf NetworkManager: <info> SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info> supplicant_init() -
> connect to device ctrl socket (1/10). 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'AP_SCAN 1' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'ADD_NETWORK' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was '0'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 ssid 3830322e3158' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 proto WPA' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 key_mgmt WPA-EAP' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 phase2 "auth=PAP"' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 eap TTLS' 
> Jan 24 11:14:01 popalf NetworkManager: <info> SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info> SUP: sending command
> 'SET_NETWORK 0 identity "mai03azu"' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 password <password>' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 anonymous_identity "anonymous"' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK'
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: sending command
> 'ENABLE_NETWORK 0' 
> Jan 24 11:14:01 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:01 popalf NetworkManager: <info> Activation (ath0) Stage 2
> of 5 (Device Configure) complete. 
> Jan 24 11:14:02 popalf avahi-daemon[6879]: Registering new address
> record for fe80::205:4eff:fe51:f3e on ath0.*. 
> Jan 24 11:14:06 popalf NetworkManager: <info>  Old device 'ath0'
> activating, won't change. 
> Jan 24 11:14:11 popalf kernel: [19635.596000] ath0: no IPv6 routers
> present 
> Jan 24 11:14:16 popalf NetworkManager: <info>  Old device 'ath0'
> activating, won't change. 
> Jan 24 11:14:31 popalf NetworkManager: <info>  Old device 'ath0'
> activating, won't change. 
> Jan 24 11:14:47 popalf NetworkManager: <debug> [1201169687.445058]
> nm_device_802_11_wireless_update_bssid(): Roamed from BSSID
> 00:15:FA:A1:F8:90 to 00:19:AA:51:43:60 on wireless network '802.1X'
> Jan 24 11:14:48 popalf NetworkManager: <info>  Activation
> (ath0/wireless): disconnected during association, asking for new key.
> Jan 24 11:14:48 popalf NetworkManager: <info>  Activation (ath0) New
> wireless user key requested for network '802.1X'. 
> Jan 24 11:14:53 popalf NetworkManager: <debug> [1201169693.444811]
> nm_device_802_11_wireless_update_bssid(): Roamed from BSSID
> 00:15:FA:A1:F8:90 to 00:19:AA:51:43:60 on wireless network '802.1X' 
> Jan 24 11:14:54 popalf NetworkManager: <info>  Activation (ath0) New
> wireless user key request for network '802.1X' was canceled. 
> Jan 24 11:14:54 popalf NetworkManager: <info>  Activation (ath0) failure
> scheduled... 
> Jan 24 11:14:55 popalf NetworkManager: <info>  Activation (ath0) failed
> for access point (802.1X) 
> Jan 24 11:14:55 popalf NetworkManager: <info>  Activation (ath0)
> failed. 
> Jan 24 11:14:55 popalf NetworkManager: <info>  Deactivating device ath0.
> 
> there the new password dialog came up
> i canceled it, because the data was in gconf
> so i tried to connect manual clicking on the network in nm-applet
> 
> Jan 24 11:14:58 popalf NetworkManager: <debug> [1201169698.337317]
> nm_device_802_11_wireless_get_activation_ap(): Forcing AP '802.1X' 
> Jan 24 11:14:58 popalf NetworkManager: <info>  User
> Switch: /org/freedesktop/NetworkManager/Devices/ath0 / 802.1X 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Deactivating device
> ath0. 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Device ath0 activation
> scheduled... 
> Jan 24 11:14:58 popalf NetworkManager: <info> Activation (ath0)
> started... 
> Jan 24 11:14:58 popalf NetworkManager: <info> Activation (ath0) Stage 1
> of 5 (Device Prepare) scheduled... 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation (ath0) Stage
> 1 of 5 (Device Prepare) started... 
> Jan 24 11:14:58 popalf NetworkManager: <info> Activation (ath0) Stage 2
> of 5 (Device Configure) scheduled... 
> Jan 24 11:14:58 popalf NetworkManager: <info> Activation (ath0) Stage 1
> of 5 (Device Prepare) complete. 
> Jan 2411:14:58 popalf NetworkManager: <info>  Activation (ath0) Stage 2
> of 5 (Device Configure) starting... 
> Jan 24 11:14:58 popalf NetworkManager: <info> Activation
> (ath0/wireless): access point '802.1X' is encrypted, but NO valid key
> exists.  New key needed. 
> Jan 24 11:14:58 popalfNetworkManager: <info> Activation (ath0) New
> wireless user key requested for network '802.1X'. 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation (ath0) Stage
> 2 of 5 (Device Configure) complete. 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation (ath0) New
> wireless user key for network '802.1X' received. 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation (ath0) Stage
> 1 of 5 (Device Prepare) scheduled... 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation (ath0) Stage
> 1 of 5 (Device Prepare) started... 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation (ath0) Stage
> 2 of 5 (Device Configure) scheduled... 
> Jan 24 11:14:58 popalf NetworkManager: <info> Activation (ath0) Stage 1
> of 5 (Device Prepare) complete.
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation (ath0) Stage
> 2 of 5 (Device Configure) starting... 
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation
> (ath0/wireless): access point '802.1X' is encrypted, and a key exists.
> No new key needed. 
> Jan 24 11:14:58 popalf kernel: [19682.180000] ADDRCONF(NETDEV_UP):
> ath0: link is not ready 
> Jan 24 11:14:59 popalf NetworkManager: <info>
> supplicant_interface_init() - connect to global ctrl socket (0/10). 
> Jan 24 11:14:59 popalf NetworkManager: <info>
> supplicant_interface_init() - connect to global ctrl socket (1/10). 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'INTERFACE_ADD ath0^I^Imadwifi^I/var/run/wpa_supplicant6^I' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  supplicant_init() -
> connect to device ctrl socket (1/10). 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'AP_SCAN 1' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'ADD_NETWORK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was '0'  
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 ssid 3830322e3158' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 proto WPA' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 key_mgmt WPA-EAP' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 phase2 "auth=PAP"' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 eap TTLS' 
> Jan 24 11:14:59 popalf NetworkManager: <info> SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info> SUP: sending command
> 'SET_NETWORK 0 identity "mai03azu"' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 password <password>' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'SET_NETWORK 0 anonymous_identity "anonymous"' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: sending command
> 'ENABLE_NETWORK 0' 
> Jan 24 11:14:59 popalf NetworkManager: <info>  SUP: response was 'OK' 
> Jan 24 11:14:59 popalf NetworkManager: <info> Activation (ath0) Stage 2
> of 5 (Device Configure) complete. 
> Jan 24 11:15:10 popalf kernel: [19693.980000] ADDRCONF(NETDEV_CHANGE):
> ath0: link becomes ready 
> Jan 24 11:15:11 popalf avahi-daemon[6879]: Registering new address
> record for fe80::205:4eff:fe51:f3e on ath0.*. 
> Jan 24 11:15:15 popalf NetworkManager: <info>  Old device 'ath0'
> activating, won't change. 
> Jan 24 11:15:20 popalf kernel: [19703.996000] ath0: no IPv6 routers
> present 
> Jan 24 11:16:25 popalf NetworkManager: <info>  Old device 'ath0'
> activating, won't change. 
> Jan 24 11:16:30 popalf NetworkManager: <info>  Activation
> (ath0/wireless): disconnected during association, asking for new key. 
> Jan 24 11:16:30 popalf NetworkManager: <info>  Activation (ath0) New
> wireless user key requested for network '802.1X'. 
> Jan 24 11:16:32 popalf NetworkManager: <info>  Activation (ath0) New
> wireless user key request for network '802.1X' was canceled. 
> Jan 24 11:16:32 popalf NetworkManager: <info> Activation (ath0) failure
> scheduled... 
> Jan 24 11:16:32 popalf NetworkManager: <info>  Activation (ath0) failed
> for access point (802.1X) 
> Jan 24 11:16:32 popalf NetworkManager: <info>  Activation (ath0)
> failed. 
> Jan 24 11:16:32 popalf NetworkManager: <info> Deactivating device ath0.
> 
> 
> why this happend,
> Jan 24 11:14:58 popalf NetworkManager: <info> Activation
> (ath0/wireless): access point '802.1X' is encrypted, but NO valid key
> exists.  New key needed. 
> ...
> Jan 24 11:14:58 popalfNetworkManager: <info> Activation (ath0) New
> wireless user key requested for network '802.1X'. <-- password dialog
> ...
> Jan 24 11:14:58 popalf NetworkManager: <info>  Activation
> (ath0/wireless): access point '802.1X' is encrypted, and a key exists.
> No new key needed. 
> ...
> Jan 24 11:16:30 popalf NetworkManager: <info>  Activation
> (ath0/wireless): disconnected during association, asking for new key. 
> Jan 24 11:16:30 popalf NetworkManager: <info>  Activation (ath0) New
> wireless user key requested for network '802.1X'. 
> 
> 
> thx for any answer that can explain this
> greetings Ralf

I think it causes a scan.

- --
 ---- _  _ _  _ ___  _  _  _
 |Y#| |  | |\/| |  \ |\ |  | |Ryan Novosielski - Systems Programmer II
 |$&| |__| |  | |__/ | \| _| |novosirj umdnj edu - 973/972.0922 (2-0922)
 \__/ Univ. of Med. and Dent.|IST/AST - NJMS Medical Science Bldg - C630
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.6 (GNU/Linux)
Comment: Using GnuPG with Mozilla - http://enigmail.mozdev.org

iD8DBQFHmMLCmb+gadEcsb4RAmH1AKCrsj9pGjRvCr1WeOmFx1I+mJqcVgCgjrys
5ONfhlZ4QGPzWsNXzt0+wfM=
=Bobz
-----END PGP SIGNATURE-----

begin:vcard
fn:Ryan Novosielski
n:Novosielski;Ryan
org:UMDNJ;IST/AST
adr;dom:MSB C630;;185 South Orange Avenue;Newark;NJ;07103
email;internet:novosirj umdnj edu
title:Systems Programmer III
tel;work:(973) 972-0922
tel;fax:(973) 972-7412
tel;pager:(866) 20-UMDNJ
x-mozilla-html:FALSE
version:2.1
end:vcard