On Wed, 2015-03-18 at 21:24 +0000, Jürgen Bausa wrote: > Dan Williams <dcbw@...> writes: > > > > > > > > > Thanks, that worked. Now I have firmware and nvram-file and the driver > seems > > > to load ok. At least I have an interface wlan0. > > > > > > However, I am not able to connect.Network-manager just says "interface is > > > being set up ..." forever. I have no idea howto debug this. In the other > > > post you said that the nl80211 driver should be used instead of wext. I > > > found that nl80211 is the default for network-manager. So, whats going > wrong > > > here? > > > > Could you provide more NetworkManager logs? They should look like this; > > where do your logs stop? > > > > > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0) starting > connection 'tuxgang' > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) scheduled... > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) started... > Mar 18 22:16:40 lina NetworkManager[532]: <info> (wlan0): device state > change: disconnected -> prepare (reason 'none') [30 40 0] > Mar 18 22:16:40 lina NetworkManager[532]: <info> NetworkManager state is now > CONNECTING > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) scheduled... > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) complete. > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) starting... > Mar 18 22:16:40 lina NetworkManager[532]: <info> (wlan0): device state > change: prepare -> config (reason 'none') [40 50 0] > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0/wireless): > connection 'tuxgang' has security, and secrets exist. No new secrets needed. > Mar 18 22:16:40 lina NetworkManager[532]: <info> Config: added 'ssid' value > 'tuxgang' > Mar 18 22:16:40 lina NetworkManager[532]: <info> Config: added 'scan_ssid' > value '1' > Mar 18 22:16:40 lina NetworkManager[532]: <info> Config: added 'key_mgmt' > value 'WPA-PSK' > Mar 18 22:16:40 lina NetworkManager[532]: <info> Config: added 'auth_alg' > value 'OPEN' > Mar 18 22:16:40 lina NetworkManager[532]: <info> Config: added 'psk' value > '<omitted>' > Mar 18 22:16:40 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) complete. > Mar 18 22:16:40 lina NetworkManager[532]: <info> Config: set interface > ap_scan to 1 > Mar 18 22:16:40 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: inactive -> scanning > Mar 18 22:16:50 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: scanning -> associating > Mar 18 22:17:00 lina NetworkManager[532]: <warn> Connection disconnected > (reason -3) Something is still wrong with the driver/device. Here, even though a scan has already been done and the SSID found (otherwise NM wouldn't have started a connection in the first place) the supplicant is doing another scan (10s) and then attempting to associate, which takes 10s before NM kills the attempt. So ignoring the scan issues (eg, why is another 10s scan requires when the SSID is already in the supplicant's network list) it still has association problems. NetworkManager allows up to 20s for an auth/assoc since that really, really should be enough. If it's not enough, then something is seriously wrong with the hardware or the wifi network. Next steps: What does 'dmesg' say here? Anything about association tries? After that we try getting supplicant debug logs and figuring out what's going on from its point of view. Dan > Mar 18 22:17:00 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: associating -> disconnected > Mar 18 22:17:00 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: disconnected -> scanning > Mar 18 22:17:05 lina NetworkManager[532]: <warn> Activation (wlan0/wireless): > association took too long. > Mar 18 22:17:05 lina NetworkManager[532]: <info> (wlan0): device state > change: config -> need-auth (reason 'none') [50 60 0] > Mar 18 22:17:05 lina NetworkManager[532]: <warn> Activation (wlan0/wireless): > asking for new secrets > Mar 18 22:17:05 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > Mar 18 22:17:05 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > Mar 18 22:17:29 lina NetworkManager[532]: (NetworkManager:532): libnm-util- > CRITICAL **: get_secret_flags: assertion 'is_secret_prop (setting, > secret_name, error)' failed > Mar 18 22:17:29 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) scheduled... > Mar 18 22:17:29 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) started... > Mar 18 22:17:29 lina NetworkManager[532]: <info> (wlan0): device state > change: need-auth -> prepare (reason 'none') [60 40 0] > Mar 18 22:17:29 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) scheduled... > Mar 18 22:17:29 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) complete. > Mar 18 22:17:29 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) starting... > Mar 18 22:17:29 lina NetworkManager[532]: <info> (wlan0): device state > change: prepare -> config (reason 'none') [40 50 0] > Mar 18 22:17:29 lina NetworkManager[532]: <info> Activation (wlan0/wireless): > connection 'tuxgang' has security, and secrets exist. No new secrets needed. > Mar 18 22:17:29 lina NetworkManager[532]: <info> Config: added 'ssid' value > 'tuxgang' > Mar 18 22:17:29 lina NetworkManager[532]: <info> Config: added 'scan_ssid' > value '1' > Mar 18 22:17:29 lina NetworkManager[532]: <info> Config: added 'key_mgmt' > value 'WPA-PSK' > Mar 18 22:17:29 lina NetworkManager[532]: <info> Config: added 'auth_alg' > value 'OPEN' > Mar 18 22:17:29 lina NetworkManager[532]: <info> Config: added 'psk' value > '<omitted>' > Mar 18 22:17:29 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) complete. > Mar 18 22:17:29 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > Mar 18 22:17:29 lina NetworkManager[532]: <info> Config: set interface > ap_scan to 1 > Mar 18 22:17:29 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: scanning -> associated > Mar 18 22:17:29 lina NetworkManager[532]: <warn> Connection disconnected > (reason -3) > Mar 18 22:17:29 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: associated -> disconnected > Mar 18 22:17:29 lina NetworkManager[532]: <warn> Connection disconnected > (reason 6) > Mar 18 22:17:29 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: disconnected -> scanning > Mar 18 22:17:39 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: scanning -> associating > Mar 18 22:17:49 lina NetworkManager[532]: <warn> Connection disconnected > (reason -3) > Mar 18 22:17:49 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: associating -> disconnected > Mar 18 22:17:49 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: disconnected -> scanning > Mar 18 22:17:54 lina NetworkManager[532]: <warn> Activation (wlan0/wireless): > association took too long. > Mar 18 22:17:54 lina NetworkManager[532]: <info> (wlan0): device state > change: config -> need-auth (reason 'none') [50 60 0] > Mar 18 22:17:54 lina NetworkManager[532]: <warn> Activation (wlan0/wireless): > asking for new secrets > Mar 18 22:17:54 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > Mar 18 22:17:54 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > Mar 18 22:18:00 lina NetworkManager[532]: (NetworkManager:532): libnm-util- > CRITICAL **: get_secret_flags: assertion 'is_secret_prop (setting, > secret_name, error)' failed > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) scheduled... > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) started... > Mar 18 22:18:00 lina NetworkManager[532]: <info> (wlan0): device state > change: need-auth -> prepare (reason 'none') [60 40 0] > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) scheduled... > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) complete. > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) starting... > Mar 18 22:18:00 lina NetworkManager[532]: <info> (wlan0): device state > change: prepare -> config (reason 'none') [40 50 0] > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0/wireless): > connection 'tuxgang' has security, and secrets exist. No new secrets needed. > Mar 18 22:18:00 lina NetworkManager[532]: <info> Config: added 'ssid' value > 'tuxgang' > Mar 18 22:18:00 lina NetworkManager[532]: <info> Config: added 'scan_ssid' > value '1' > Mar 18 22:18:00 lina NetworkManager[532]: <info> Config: added 'key_mgmt' > value 'WPA-PSK' > Mar 18 22:18:00 lina NetworkManager[532]: <info> Config: added 'auth_alg' > value 'OPEN' > Mar 18 22:18:00 lina NetworkManager[532]: <info> Config: added 'psk' value > '<omitted>' > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) complete. > Mar 18 22:18:00 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > Mar 18 22:18:00 lina NetworkManager[532]: <info> Config: set interface > ap_scan to 1 > Mar 18 22:18:00 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: scanning -> 4-way handshake > Mar 18 22:18:00 lina NetworkManager[532]: <warn> Connection disconnected > (reason 6) > Mar 18 22:18:00 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: 4-way handshake -> disconnected > Mar 18 22:18:00 lina NetworkManager[532]: <info> Activation (wlan0/wireless): > disconnected during association, asking for new key. > Mar 18 22:18:00 lina NetworkManager[532]: <info> (wlan0): device state > change: config -> need-auth (reason 'supplicant-disconnect') [50 60 8] > Mar 18 22:18:00 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: disconnected -> inactive > Mar 18 22:18:07 lina NetworkManager[532]: (NetworkManager:532): libnm-util- > CRITICAL **: get_secret_flags: assertion 'is_secret_prop (setting, > secret_name, error)' failed > Mar 18 22:18:07 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) scheduled... > Mar 18 22:18:07 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) started... > Mar 18 22:18:07 lina NetworkManager[532]: <info> (wlan0): device state > change: need-auth -> prepare (reason 'none') [60 40 0] > Mar 18 22:18:07 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) scheduled... > Mar 18 22:18:07 lina NetworkManager[532]: <info> Activation (wlan0) Stage 1 > of 5 (Device Prepare) complete. > Mar 18 22:18:07 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) starting... > Mar 18 22:18:07 lina NetworkManager[532]: <info> (wlan0): device state > change: prepare -> config (reason 'none') [40 50 0] > Mar 18 22:18:07 lina NetworkManager[532]: <info> Activation (wlan0/wireless): > connection 'tuxgang' has security, and secrets exist. No new secrets needed. > Mar 18 22:18:07 lina NetworkManager[532]: <info> Config: added 'ssid' value > 'tuxgang' > Mar 18 22:18:07 lina NetworkManager[532]: <info> Config: added 'scan_ssid' > value '1' > Mar 18 22:18:07 lina NetworkManager[532]: <info> Config: added 'key_mgmt' > value 'WPA-PSK' > Mar 18 22:18:07 lina NetworkManager[532]: <info> Config: added 'auth_alg' > value 'OPEN' > Mar 18 22:18:07 lina NetworkManager[532]: <info> Config: added 'psk' value > '<omitted>' > Mar 18 22:18:07 lina NetworkManager[532]: <info> Activation (wlan0) Stage 2 > of 5 (Device Configure) complete. > Mar 18 22:18:07 lina NetworkManager[532]: <info> Config: set interface > ap_scan to 1 > Mar 18 22:18:07 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: inactive -> associating > Mar 18 22:18:17 lina NetworkManager[532]: <warn> Connection disconnected > (reason -3) > Mar 18 22:18:17 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: associating -> disconnected > Mar 18 22:18:17 lina NetworkManager[532]: <info> (wlan0): supplicant > interface state: disconnected -> scanning > Mar 18 22:18:32 lina NetworkManager[532]: <warn> Activation (wlan0/wireless): > association took too long. > Mar 18 22:18:32 lina NetworkManager[532]: <info> (wlan0): device state > change: config -> need-auth (reason 'none') [50 60 0] > Mar 18 22:18:32 lina NetworkManager[532]: <warn> Activation (wlan0/wireless): > asking for new secrets > Mar 18 22:18:32 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > Mar 18 22:18:32 lina NetworkManager[532]: <warn> Couldn't disconnect > supplicant interface: This interface is not connected. > > > > > -- > To unsubscribe from this list: send the line "unsubscribe linux-wireless" in > the body of a message to majordomo@xxxxxxxxxxxxxxx > More majordomo info at http://vger.kernel.org/majordomo-info.html -- To unsubscribe from this list: send the line "unsubscribe linux-wireless" in the body of a message to majordomo@xxxxxxxxxxxxxxx More majordomo info at http://vger.kernel.org/majordomo-info.html
