[pkg-wpa-devel] Bug#579297: still affected by this bug

[Andres Cimmarusti]

found 579297 0.7.3-6
tags 579297 help
thanks

Running wheezy here. I'm still affected by this bug. Here is the
Ubuntu bug report:
https://bugs.launchpad.net/ubuntu/+source/wpasupplicant/+bug/429370

Like it was mentioned before, compiling wpasupplicant with gnutls
seems to solve the problem for some people.

I'm attaching my syslog while the disconnection and subsequent failure
to connect happen. Furthermore, after a disconnection from 'eduroam',
I cannot connect to another wireless network for several minutes
(including WEP without authentication, e.g. look for umd in syslog).

I was not actually seeing this problem using squeeze (though my
interface was on wlan1, instead of wlan0) and a vanilla longterm
kernel 3.0.x. This issue is quite annoying. Is the problem still
present for the other bug reporter?
-------------- next part --------------
Mar 19 11:16:32 lc2131 NetworkManager[1158]: <warn> Activation (wlan0/wireless): association took too long.
Mar 19 11:16:32 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Mar 19 11:16:32 lc2131 NetworkManager[1158]: <warn> Activation (wlan0/wireless): asking for new secrets
Mar 19 11:16:32 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Mar 19 11:16:32 lc2131 NetworkManager[1158]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Mar 19 11:16:35 lc2131 NetworkManager[1158]: get_secret_flags: assertion `is_secret_prop (setting, secret_name, error)' failed
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Activation (wlan0/wireless): connection 'Auto eduroam' has security, and secrets exist.  No new secrets needed.
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'ssid' value 'eduroam'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'scan_ssid' value '1'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'key_mgmt' value 'WPA-EAP'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'password' value '<omitted>'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'eap' value 'TTLS'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'fragment_size' value '1300'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'phase2' value 'auth=MSCHAPV2'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'identity' value 'candres at umd.edu'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: added 'bgscan' value 'simple:30:-45:300'
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> Config: set interface ap_scan to 1
Mar 19 11:16:35 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Mar 19 11:16:38 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:ab:01:36 (SSID='eduroam' freq=5220 MHz)
Mar 19 11:16:38 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Mar 19 11:16:38 lc2131 kernel: [  816.843896] wlan0: authenticate with 00:26:cb:ab:01:36 (try 1)
Mar 19 11:16:38 lc2131 kernel: [  817.040916] wlan0: authenticate with 00:26:cb:ab:01:36 (try 2)
Mar 19 11:16:38 lc2131 kernel: [  817.240720] wlan0: authenticate with 00:26:cb:ab:01:36 (try 3)
Mar 19 11:16:39 lc2131 kernel: [  817.440475] wlan0: authentication with 00:26:cb:ab:01:36 timed out
Mar 19 11:16:46 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:ab:01:36 (SSID='eduroam' freq=5220 MHz)
Mar 19 11:16:46 lc2131 kernel: [  825.223868] wlan0: authenticate with 00:26:cb:ab:01:36 (try 1)
Mar 19 11:16:47 lc2131 kernel: [  825.423696] wlan0: authenticate with 00:26:cb:ab:01:36 (try 2)
Mar 19 11:16:47 lc2131 kernel: [  825.623454] wlan0: authenticate with 00:26:cb:ab:01:36 (try 3)
Mar 19 11:16:47 lc2131 kernel: [  825.823293] wlan0: authentication with 00:26:cb:ab:01:36 timed out
Mar 19 11:16:55 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:aa:fe:c9 (SSID='eduroam' freq=2462 MHz)
Mar 19 11:16:55 lc2131 kernel: [  833.659511] wlan0: direct probe to 00:26:cb:aa:fe:c9 (try 1/3)
Mar 19 11:16:55 lc2131 kernel: [  833.858482] wlan0: direct probe to 00:26:cb:aa:fe:c9 (try 2/3)
Mar 19 11:16:55 lc2131 kernel: [  834.058288] wlan0: direct probe to 00:26:cb:aa:fe:c9 (try 3/3)
Mar 19 11:16:55 lc2131 kernel: [  834.258050] wlan0: direct probe to 00:26:cb:aa:fe:c9 timed out
Mar 19 11:17:00 lc2131 NetworkManager[1158]: <warn> Activation (wlan0/wireless): association took too long.
Mar 19 11:17:00 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Mar 19 11:17:00 lc2131 NetworkManager[1158]: <warn> Activation (wlan0/wireless): asking for new secrets
Mar 19 11:17:00 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Mar 19 11:17:00 lc2131 NetworkManager[1158]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Mar 19 11:17:01 lc2131 /USR/SBIN/CRON[2449]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Mar 19 11:17:03 lc2131 NetworkManager[1158]: get_secret_flags: assertion `is_secret_prop (setting, secret_name, error)' failed
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Activation (wlan0/wireless): connection 'Auto eduroam' has security, and secrets exist.  No new secrets needed.
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'ssid' value 'eduroam'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'scan_ssid' value '1'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'key_mgmt' value 'WPA-EAP'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'password' value '<omitted>'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'eap' value 'TTLS'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'fragment_size' value '1300'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'phase2' value 'auth=MSCHAPV2'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'identity' value 'candres at umd.edu'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: added 'bgscan' value 'simple:30:-45:300'
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> Config: set interface ap_scan to 1
Mar 19 11:17:03 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Mar 19 11:17:06 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:aa:fe:c9 (SSID='eduroam' freq=2462 MHz)
Mar 19 11:17:06 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Mar 19 11:17:06 lc2131 kernel: [  844.313376] wlan0: direct probe to 00:26:cb:aa:fe:c9 (try 1/3)
Mar 19 11:17:06 lc2131 kernel: [  844.510907] wlan0: direct probe to 00:26:cb:aa:fe:c9 (try 2/3)
Mar 19 11:17:06 lc2131 kernel: [  844.710653] wlan0: direct probe to 00:26:cb:aa:fe:c9 (try 3/3)
Mar 19 11:17:06 lc2131 kernel: [  844.910565] wlan0: direct probe to 00:26:cb:aa:fe:c9 timed out
Mar 19 11:17:14 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:ab:01:36 (SSID='eduroam' freq=5220 MHz)
Mar 19 11:17:14 lc2131 kernel: [  852.782964] wlan0: authenticate with 00:26:cb:ab:01:36 (try 1)
Mar 19 11:17:14 lc2131 kernel: [  852.981738] wlan0: authenticate with 00:26:cb:ab:01:36 (try 2)
Mar 19 11:17:14 lc2131 kernel: [  853.181494] wlan0: authenticate with 00:26:cb:ab:01:36 (try 3)
Mar 19 11:17:15 lc2131 kernel: [  853.381284] wlan0: authentication with 00:26:cb:ab:01:36 timed out
Mar 19 11:17:22 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:ab:01:36 (SSID='eduroam' freq=5220 MHz)
Mar 19 11:17:22 lc2131 kernel: [  861.232092] wlan0: authenticate with 00:26:cb:ab:01:36 (try 1)
Mar 19 11:17:23 lc2131 kernel: [  861.428524] wlan0: authenticate with 00:26:cb:ab:01:36 (try 2)
Mar 19 11:17:23 lc2131 kernel: [  861.628209] wlan0: authenticate with 00:26:cb:ab:01:36 (try 3)
Mar 19 11:17:23 lc2131 kernel: [  861.828084] wlan0: authentication with 00:26:cb:ab:01:36 timed out
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <warn> Activation (wlan0/wireless): association took too long.
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: config -> failed (reason 'no-secrets') [50 120 7]
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <warn> Activation (wlan0) failed for access point (eduroam)
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <info> Marking connection 'Auto eduroam' invalid.
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <warn> Activation (wlan0) failed.
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <info> (wlan0): deactivating device (reason 'none') [0]
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Mar 19 11:17:27 lc2131 NetworkManager[1158]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0) starting connection 'Auto umd'
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0/wireless): connection 'Auto umd' requires no security.  No secrets needed.
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Config: added 'ssid' value 'umd'
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Config: added 'scan_ssid' value '1'
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Config: added 'key_mgmt' value 'NONE'
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> Config: set interface ap_scan to 1
Mar 19 11:19:11 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Mar 19 11:19:14 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:ab:01:3f (SSID='umd' freq=5220 MHz)
Mar 19 11:19:14 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Mar 19 11:19:14 lc2131 kernel: [  972.702828] wlan0: authenticate with 00:26:cb:ab:01:3f (try 1)
Mar 19 11:19:14 lc2131 kernel: [  972.898887] wlan0: authenticate with 00:26:cb:ab:01:3f (try 2)
Mar 19 11:19:14 lc2131 kernel: [  973.098747] wlan0: authenticate with 00:26:cb:ab:01:3f (try 3)
Mar 19 11:19:15 lc2131 kernel: [  973.298522] wlan0: authentication with 00:26:cb:ab:01:3f timed out
Mar 19 11:19:23 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:ab:01:30 (SSID='umd' freq=2412 MHz)
Mar 19 11:19:23 lc2131 kernel: [  981.178274] wlan0: direct probe to 00:26:cb:ab:01:30 (try 1/3)
Mar 19 11:19:23 lc2131 kernel: [  981.377723] wlan0: direct probe to 00:26:cb:ab:01:30 (try 2/3)
Mar 19 11:19:23 lc2131 kernel: [  981.577405] wlan0: direct probe to 00:26:cb:ab:01:30 (try 3/3)
Mar 19 11:19:23 lc2131 kernel: [  981.777242] wlan0: direct probe to 00:26:cb:ab:01:30 timed out
Mar 19 11:19:31 lc2131 wpa_supplicant[1221]: Trying to authenticate with 00:26:cb:ab:01:3f (SSID='umd' freq=5220 MHz)
Mar 19 11:19:31 lc2131 kernel: [  989.616558] wlan0: authenticate with 00:26:cb:ab:01:3f (try 1)
Mar 19 11:19:31 lc2131 kernel: [  989.816448] wlan0: authenticate with 00:26:cb:ab:01:3f (try 2)
Mar 19 11:19:31 lc2131 kernel: [  990.016294] wlan0: authenticate with 00:26:cb:ab:01:3f (try 3)
Mar 19 11:19:32 lc2131 kernel: [  990.216019] wlan0: authentication with 00:26:cb:ab:01:3f timed out
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: config -> failed (reason 'supplicant-timeout') [50 120 11]
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <warn> Activation (wlan0) failed for access point (umd)
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <warn> Activation (wlan0) failed.
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <info> (wlan0): deactivating device (reason 'none') [0]
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Mar 19 11:19:36 lc2131 NetworkManager[1158]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.