Comment 51 for bug 969343

Happening after my upgrade to 12.04

I've tried Diane Trout's patched wpa_supplicant and it did not work for me, so this may be a related but non-identical issue

The WAP security is WPA/WPA2 personal (PSK), not enterprise, as the other reports.

Relevant sections of syslog are:
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0) starting connection 'Auto XYZ'
Jun 12 14:29:03 mule NetworkManager[938]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jun 12 14:29:03 mule NetworkManager[938]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0/wireless): access point 'Auto XYZ' has security, but secrets are required.
Jun 12 14:29:03 mule NetworkManager[938]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Jun 12 14:29:03 mule NetworkManager[938]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jun 12 14:29:09 mule NetworkManager[938]: get_secret_flags: assertion `is_secret_prop (setting, secret_name, error)' failed
Jun 12 14:29:09 mule NetworkManager[938]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jun 12 14:29:09 mule NetworkManager[938]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jun 12 14:29:09 mule NetworkManager[938]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Jun 12 14:29:09 mule NetworkManager[938]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jun 12 14:29:09 mule NetworkManager[938]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jun 12 14:29:09 mule NetworkManager[938]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jun 12 14:29:09 mule NetworkManager[938]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Jun 12 14:29:09 mule NetworkManager[938]: <info> Activation (wlan0/wireless): connection 'Auto XYZ' has security, and secrets exist. No new secrets needed.
Jun 12 14:29:09 mule NetworkManager[938]: <info> Config: added 'ssid' value 'XYZ'
Jun 12 14:29:09 mule NetworkManager[938]: <info> Config: added 'scan_ssid' value '1'
Jun 12 14:29:09 mule NetworkManager[938]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Jun 12 14:29:09 mule NetworkManager[938]: <info> Config: added 'auth_alg' value 'OPEN'
Jun 12 14:29:09 mule NetworkManager[938]: <info> Config: added 'psk' value '<omitted>'
Jun 12 14:29:09 mule NetworkManager[938]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jun 12 14:29:09 mule NetworkManager[938]: <info> Config: set interface ap_scan to 1
Jun 12 14:29:10 mule NetworkManager[938]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Jun 12 14:29:13 mule wpa_supplicant[4971]: Trying to authenticate with xx:xx:xx:xx:xx:xx (SSID='XYZ' freq=2437 MHz)
Jun 12 14:29:13 mule NetworkManager[938]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Jun 12 14:29:13 mule kernel: [13401.818623] wlan0: authenticate with xx:xx:xx:xx:xx:xx (try 1)
Jun 12 14:29:13 mule wpa_supplicant[4971]: Trying to associate with xx:xx:xx:xx:xx:xx (SSID='XYZ' freq=2437 MHz)
Jun 12 14:29:13 mule kernel: [13401.823090] wlan0: authenticated
Jun 12 14:29:13 mule NetworkManager[938]: <info> (wlan0): supplicant interface state: authenticating -> associating
Jun 12 14:29:13 mule kernel: [13401.861540] wlan0: associate with xx:xx:xx:xx:xx:xx (try 1)
Jun 12 14:29:13 mule kernel: [13401.864953] wlan0: RX ReassocResp from xx:xx:xx:xx:xx:xx (capab=0x431 status=0 aid=26)
Jun 12 14:29:13 mule kernel: [13401.864957] wlan0: associated
Jun 12 14:29:13 mule wpa_supplicant[4971]: Associated with xx:xx:xx:xx:xx:xx
Jun 12 14:29:13 mule NetworkManager[938]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake
Jun 12 14:29:13 mule kernel: [13402.164079] wlan0: deauthenticated from xx:xx:xx:xx:xx:xx (Reason: 23)
Jun 12 14:29:13 mule wpa_supplicant[4971]: WPA: 4-Way Handshake failed - pre-shared key may be incorrect
Jun 12 14:29:13 mule wpa_supplicant[4971]: CTRL-EVENT-DISCONNECTED bssid=xx:xx:xx:xx:xx:xx reason=23

I tried enabling debug logging for wpa_supplicant, but the ubuntu configuration is different enough that it wasn't working for me (adding -dddt -f /var/log/wpasupplicant.log to the dbus configuration resulted in pretty bad system instability in both gnome-shell and network-manager)

I've also tried ignoring ipv6 per some ?(un)related? bug reports, but that had no effect.

any thoughts?