[Pkg-utopia-maintainers] Bug#460828: Further info

[alberto maurizi]

	I noticed that, if I cancel the request of a passphrase, then
	NetworkManager "realises" that a key exists, however it
	disconnectes immediately after connection.

	If I reiterate the process It connects without asking password.

	In both cases I do not provide a key but it seems nm can manage
	to find it (maybe through keyring-manager).

	However, I'm not sure this would happens the same at all times.
	It seems more like a random behaviour.

	Hope this helps.



	First attempt ... (Cancel butto clicked when nm asks for a password)

Jan 18 09:21:40 krsna NetworkManager: <info>  Updating allowed wireless network lists. 
Jan 18 09:21:40 krsna NetworkManager: <info>  SWITCH: no current connection, found better connection 'eth2'. 
Jan 18 09:21:40 krsna dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth2 for sub-path eth2.dbus.get.reason
Jan 18 09:21:40 krsna NetworkManager: <info>  Will activate connection 'eth2/augh.net'. 
Jan 18 09:21:40 krsna NetworkManager: <info>  Device eth2 activation scheduled... 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) started... 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) scheduled... 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) started... 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) scheduled... 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) complete. 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) starting... 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2/wireless): access point 'augh.net' is encrypted, but NO valid key exists.  New key needed. 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) New wireless user key requested for network 'augh.net'. 
Jan 18 09:21:40 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) complete. 
Jan 18 09:21:54 krsna NetworkManager: <info>  Activation (eth2) New wireless user key for network 'augh.net' received. 
Jan 18 09:21:54 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) scheduled... 
Jan 18 09:21:54 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) started... 
Jan 18 09:21:54 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) scheduled... 
Jan 18 09:21:54 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) complete. 
Jan 18 09:21:54 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) starting... 
Jan 18 09:21:54 krsna NetworkManager: <info>  Activation (eth2/wireless): access point 'augh.net' is encrypted, and a key exists.  No new key needed. 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'INTERFACE_ADD eth2^I^Iwext^I/var/run/wpa_supplicant^I' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'AP_SCAN 1' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'ADD_NETWORK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was '0' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 ssid 617567682e6e6574' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 proto WPA2' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 key_mgmt WPA-PSK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 psk <key>' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: sending command 'ENABLE_NETWORK 0' 
Jan 18 09:21:56 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:21:56 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) complete. 
Jan 18 09:23:11 krsna NetworkManager: <info>  Activation (eth2/wireless): disconnected during association, asking for new key. 
Jan 18 09:23:11 krsna NetworkManager: <info>  Activation (eth2) New wireless user key requested for network 'augh.net'. 
Jan 18 09:23:20 krsna kernel: ieee80211_crypt: registered algorithm 'CCMP'
Jan 18 09:23:50 krsna NetworkManager: <info>  Activation (eth2) New wireless user key request for network 'augh.net' was canceled. 
Jan 18 09:23:50 krsna NetworkManager: <info>  Activation (eth2) failure scheduled... 
Jan 18 09:23:50 krsna NetworkManager: <info>  Activation (eth2) failed for access point (augh.net) 
Jan 18 09:23:50 krsna NetworkManager: <info>  Activation (eth2) failed. 
Jan 18 09:23:50 krsna NetworkManager: <info>  Deactivating device eth2. 


	After retry ... (no password box appears though the log seems quite the same)

Jan 18 09:23:53 krsna NetworkManager: <debug> [1200644633.433686] nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'augh.net' 
Jan 18 09:23:53 krsna NetworkManager: <info>  User Switch: /org/freedesktop/NetworkManager/Devices/eth2 / augh.net 
Jan 18 09:23:53 krsna NetworkManager: <info>  Deactivating device eth2. 
Jan 18 09:23:53 krsna dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth2 for sub-path eth2.dbus.get.reason
Jan 18 09:23:53 krsna NetworkManager: <info>  Device eth2 activation scheduled... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) started... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) scheduled... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) started... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) scheduled... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) complete. 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) starting... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2/wireless): access point 'augh.net' is encrypted, but NO valid key exists.  New key needed. 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) New wireless user key requested for network 'augh.net'. 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) complete. 
Jan 18 09:23:53 krsna kernel: ADDRCONF(NETDEV_UP): eth2: link is not ready
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) New wireless user key for network 'augh.net' received. 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) scheduled... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) started... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) scheduled... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 1 of 5 (Device Prepare) complete. 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) starting... 
Jan 18 09:23:53 krsna NetworkManager: <info>  Activation (eth2/wireless): access point 'augh.net' is encrypted, and a key exists.  No new key needed. 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'INTERFACE_ADD eth2^I^Iwext^I/var/run/wpa_supplicant^I' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'AP_SCAN 1' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'ADD_NETWORK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was '0' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 ssid 617567682e6e6574' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 proto WPA2' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 key_mgmt WPA-PSK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 psk <key>' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: sending command 'ENABLE_NETWORK 0' 
Jan 18 09:23:54 krsna NetworkManager: <info>  SUP: response was 'OK' 
Jan 18 09:23:54 krsna NetworkManager: <info>  Activation (eth2) Stage 2 of 5 (Device Configure) complete. 




-- 
Alberto Maurizi
              a.maurizi at isac.cnr.it	ISAC-CNR
          Phone n. +39 051 639 9615	via Gobetti 101
            Fax n. +39 051 639 9658	I-40129 Bologna, Italy
home page:		http://www.isac.cnr.it/~abl/maurizi
bolchem project:	http://www.isac.cnr.it/bolchem