Arch Linux

riddle

Member

Registered: 2011-05-31

Posts: 25

[SOLVED]Gnome 3 & Network Manager & WPA-PSK

Hi,
I have encountered a problem with connection establishment.
Fresh installation, packages are updated. Yesterday it took 30s for network manager to make a wlan connection. Today it does not connect any more. However I'm able to establish connection via console (using wpa_supplicant + dhcpcd). In syslogs I can find such entries:

May 31 20:00:47 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
May 31 20:00:47 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
May 31 20:00:47 myhost NetworkManager[3082]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
May 31 20:00:47 myhost NetworkManager[3082]: <info> Activation (wlan0/wireless): connection 'Auto FuckYEAH' has security, and secrets exist.  No new secrets needed.
May 31 20:00:47 myhost NetworkManager[3082]: <info> Config: added 'ssid' value 'FuckYEAH'
May 31 20:00:47 myhost NetworkManager[3082]: <info> Config: added 'scan_ssid' value '1'
May 31 20:00:47 myhost NetworkManager[3082]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
May 31 20:00:47 myhost NetworkManager[3082]: <info> Config: added 'auth_alg' value 'OPEN'
May 31 20:00:47 myhost NetworkManager[3082]: <info> Config: added 'psk' value '<omitted>'
May 31 20:00:47 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
May 31 20:00:47 myhost NetworkManager[3082]: <info> Config: set interface ap_scan to 1
May 31 20:00:47 myhost NetworkManager[3082]: <info> (wlan0): supplicant interface state: inactive -> scanning
May 31 20:00:50 myhost kernel: [ 2355.720386] wlan0: authenticate with 00:25:9c:ee:41:73 (try 1)
May 31 20:00:50 myhost kernel: [ 2355.722718] wlan0: authenticated
May 31 20:00:50 myhost kernel: [ 2355.722834] wlan0: associate with 00:25:9c:ee:41:73 (try 1)
May 31 20:00:50 myhost NetworkManager[3082]: <info> (wlan0): supplicant interface state: scanning -> associating
May 31 20:00:50 myhost kernel: [ 2355.726302] wlan0: RX AssocResp from 00:25:9c:ee:41:73 (capab=0x411 status=0 aid=6)
May 31 20:00:50 myhost kernel: [ 2355.726305] wlan0: associated
May 31 20:00:50 myhost kernel: [ 2355.729680] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
May 31 20:00:50 myhost NetworkManager[3082]: <info> (wlan0): supplicant interface state: associating -> associated
May 31 20:00:50 myhost NetworkManager[3082]: <info> (wlan0): supplicant interface state: associated -> 4-way handshake
May 31 20:00:50 myhost dhcpcd[2993]: wlan0: carrier acquired
May 31 20:00:50 myhost dhcpcd[2993]: wlan0: rebinding lease of 192.168.1.114
May 31 20:00:50 myhost NetworkManager[3082]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
May 31 20:00:50 myhost NetworkManager[3082]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'FuckYEAH'.
May 31 20:00:50 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
May 31 20:00:50 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
May 31 20:00:50 myhost NetworkManager[3082]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
May 31 20:00:50 myhost NetworkManager[3082]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
May 31 20:00:50 myhost dhcpcd[2993]: received SIGTERM, stopping
May 31 20:00:50 myhost dhcpcd[2993]: wlan0: removing interface
May 31 20:00:50 myhost NetworkManager[3082]: <info> dhcpcd started with pid 3099
May 31 20:00:50 myhost NetworkManager[3082]: <info> Activation (wlan0) Beginning IP6 addrconf.
May 31 20:00:50 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
May 31 20:00:50 myhost dhcpcd[3099]: version 5.2.12 starting
May 31 20:00:50 myhost dhcpcd[3099]: wlan0: rebinding lease of 192.168.1.114
May 31 20:00:50 myhost NetworkManager[3082]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
May 31 20:00:52 myhost dhcpcd[3099]: wlan0: acknowledged 192.168.1.114 from 192.168.1.1
May 31 20:00:52 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) starting DHCPv6 as requested by IPv6 router...
May 31 20:00:52 myhost NetworkManager[3082]: <info> Activation (wlan0) Beginning DHCPv6 transaction (timeout in 45 seconds)
May 31 20:00:52 myhost NetworkManager[3082]: <warn> the dhcpcd backend does not support IPv6.
May 31 20:00:52 myhost dhcpcd[3099]: wlan0: checking for 192.168.1.114
May 31 20:00:57 myhost dhcpcd[3099]: wlan0: leased 192.168.1.114 for 86400 seconds
May 31 20:00:57 myhost NetworkManager[3082]: <info> (wlan0): DHCPv4 state changed preinit -> bound
May 31 20:00:57 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled...
May 31 20:00:57 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started...
May 31 20:00:57 myhost NetworkManager[3082]: <info>   address 192.168.1.114
May 31 20:00:57 myhost NetworkManager[3082]: <info>   prefix 24 (255.255.255.0)
May 31 20:00:57 myhost NetworkManager[3082]: <info>   gateway 192.168.1.1
May 31 20:00:57 myhost NetworkManager[3082]: <info>   nameserver '62.179.1.63'
May 31 20:00:57 myhost NetworkManager[3082]: <info>   nameserver '62.179.1.62'
May 31 20:00:57 myhost NetworkManager[3082]: <info>   domain name 'chello.pl'
May 31 20:00:57 myhost NetworkManager[3082]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete.

And nothing more. As you can see NM stops on stare 4 of 5. What is the 5th stage? I guess its SETTING of received configuration.
I have no idea what kind of logs will be useful to find the reason of this behavior.

P.S. I'm sorry for the essid. I'm not the network administrator

To be more mysterious.. Today NM can connect via wlan :3 (but it takes soooo looong.. about minute?:/)

Last edited by riddle (2011-06-02 20:39:00)

riddle

Member

Registered: 2011-05-31

Posts: 25

Re: [SOLVED]Gnome 3 & Network Manager & WPA-PSK

I've found solution!
I've edited wifi connection in nm-connection-editor. In IPv6 Settings tab I change method to 'Ignore'.
It had to be some problem with ipv6 router settings and it hangs on it :]

However I've change my network manager to git latest version.

Back to stable. VPNC on git latest does not work;) Wifi still works with ipv6 disabled.

Last edited by riddle (2011-06-02 20:38:33)