Comment 3 for bug 217241

Revision history for this message
Jury (jury-levykin) wrote :

/var/log/syslog is:
========================
May 11 15:36:28 ubuntu dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/ath0 for sub-path ath0.dbus.get.reason
May 11 15:36:28 ubuntu NetworkManager: <debug> [1210520188.507855] nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'levnet'
May 11 15:36:28 ubuntu NetworkManager: <info> User Switch: /org/freedesktop/NetworkManager/Devices/ath0 / levnet
May 11 15:36:28 ubuntu NetworkManager: <info> Deactivating device ath0.
May 11 15:36:28 ubuntu avahi-daemon[8016]: Withdrawing address record for fe80::214:a4ff:fe36:966e on ath0.
May 11 15:36:28 ubuntu NetworkManager: <info> Device ath0 activation scheduled...
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) started...
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) scheduled...
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) started...
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) scheduled...
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) complete.
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) starting...
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0/wireless): access point 'levnet' is encrypted, but NO valid key exists. New key needed.
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) New wireless user key requested for network 'levnet'.
May 11 15:36:28 ubuntu NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) complete.
May 11 15:37:05 ubuntu NetworkManager: <info> Activation (ath0) New wireless user key for network 'levnet' received.
May 11 15:37:05 ubuntu NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) scheduled...
May 11 15:37:05 ubuntu NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) started...
May 11 15:37:05 ubuntu NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) scheduled...
May 11 15:37:05 ubuntu NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) complete.
May 11 15:37:05 ubuntu NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) starting...
May 11 15:37:05 ubuntu NetworkManager: <info> Activation (ath0/wireless): access point 'levnet' is encrypted, and a key exists. No new key needed.
May 11 15:37:07 ubuntu NetworkManager: <info> retry to connect to global supplicant socket (try=1)
May 11 15:37:07 ubuntu NetworkManager: <info> SUP: sending command 'INTERFACE_ADD ath0^I^Imadwifi^I/var/run/wpa_supplicant0^I'
May 11 15:37:07 ubuntu kernel: [ 953.795928] ADDRCONF(NETDEV_CHANGE): ath0: link becomes ready
May 11 15:37:08 ubuntu kernel: [ 954.389092] NET: Registered protocol family 17
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was 'OK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: sending command 'AP_SCAN 1'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was 'OK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: sending command 'ADD_NETWORK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was '0'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 ssid 6c65766e6574'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was 'OK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 proto WPA'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was 'OK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 key_mgmt WPA-PSK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was 'OK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 psk <key>'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was 'OK'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: sending command 'ENABLE_NETWORK 0'
May 11 15:37:08 ubuntu NetworkManager: <info> SUP: response was 'OK'
May 11 15:37:08 ubuntu NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) complete.
May 11 15:37:09 ubuntu avahi-daemon[8016]: Registering new address record for fe80::214:a4ff:fe36:966e on ath0.*.
May 11 15:37:18 ubuntu kernel: [ 960.522798] ath0: no IPv6 routers present
May 11 15:37:23 ubuntu NetworkManager: <info> Old device 'ath0' activating, won't change.
May 11 15:37:32 ubuntu NetworkManager: <info> Supplicant state changed: 0
May 11 15:37:45 ubuntu NetworkManager: <info> Supplicant state changed: 1
May 11 15:37:45 ubuntu NetworkManager: <info> Activation (ath0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to access point 'levnet'.
May 11 15:37:45 ubuntu NetworkManager: <info> Activation (ath0) Stage 3 of 5 (IP Configure Start) scheduled.
May 11 15:37:45 ubuntu NetworkManager: <info> Activation (ath0) Stage 3 of 5 (IP Configure Start) started...
May 11 15:37:46 ubuntu NetworkManager: <info> Activation (ath0) Beginning DHCP transaction.
May 11 15:37:46 ubuntu NetworkManager: <info> Activation (ath0) Stage 3 of 5 (IP Configure Start) complete.
May 11 15:37:46 ubuntu NetworkManager: <info> DHCP daemon state is now 12 (successfully started) for interface ath0
May 11 15:37:46 ubuntu dhclient: wifi0: unknown hardware address type 801
May 11 15:37:47 ubuntu NetworkManager: <info> Old device 'ath0' activating, won't change.
May 11 15:37:48 ubuntu NetworkManager: <info> DHCP daemon state is now 1 (starting) for interface ath0
May 11 15:37:48 ubuntu dhclient: wifi0: unknown hardware address type 801
May 11 15:37:49 ubuntu dhclient: DHCPDISCOVER on ath0 to 255.255.255.255 port 67 interval 4
May 11 15:38:01 ubuntu last message repeated 3 times
May 11 15:38:05 ubuntu dhclient: DHCPDISCOVER on ath0 to 255.255.255.255 port 67 interval 7
May 11 15:38:12 ubuntu dhclient: DHCPDISCOVER on ath0 to 255.255.255.255 port 67 interval 8
May 11 15:38:20 ubuntu dhclient: No DHCPOFFERS received.
May 11 15:38:22 ubuntu avahi-autoipd(ath0)[9154]: Found user 'avahi-autoipd' (UID 104) and group 'avahi-autoipd' (GID 112).
May 11 15:38:22 ubuntu avahi-autoipd(ath0)[9154]: Successfully called chroot().
May 11 15:38:22 ubuntu avahi-autoipd(ath0)[9154]: Successfully dropped root privileges.
May 11 15:38:22 ubuntu avahi-autoipd(ath0)[9154]: Starting with address 169.254.6.125
May 11 15:38:28 ubuntu avahi-autoipd(ath0)[9154]: Callout BIND, address 169.254.6.125 on interface ath0
May 11 15:38:28 ubuntu avahi-daemon[8016]: Joining mDNS multicast group on interface ath0.IPv4 with address 169.254.6.125.
May 11 15:38:28 ubuntu avahi-daemon[8016]: New relevant interface ath0.IPv4 for mDNS.
May 11 15:38:28 ubuntu avahi-daemon[8016]: Registering new address record for 169.254.6.125 on ath0.IPv4.
May 11 15:38:32 ubuntu avahi-autoipd(ath0)[9154]: Successfully claimed IP address 169.254.6.125
May 11 15:38:32 ubuntu NetworkManager: <info> DHCP daemon state is now 9 (fail) for interface ath0
May 11 15:38:32 ubuntu NetworkManager: <info> Activation (ath0) Stage 4 of 5 (IP Configure Timeout) scheduled...
May 11 15:38:32 ubuntu NetworkManager: <info> Activation (ath0) Stage 4 of 5 (IP Configure Timeout) started...
May 11 15:38:32 ubuntu NetworkManager: <info> Activation (ath0) failure scheduled...
May 11 15:38:32 ubuntu NetworkManager: <info> Activation (ath0) Stage 4 of 5 (IP Configure Timeout) complete.
May 11 15:38:32 ubuntu dhcdbd: Unrequested down ?:3
May 11 15:38:32 ubuntu NetworkManager: <info> DHCP daemon state is now 14 (normal exit) for interface ath0
May 11 15:38:32 ubuntu NetworkManager: <info> Activation (ath0) failed for access point (levnet)
May 11 15:38:32 ubuntu NetworkManager: <info> Activation (ath0) failed.
May 11 15:38:32 ubuntu NetworkManager: <info> Deactivating device ath0.
May 11 15:38:32 ubuntu avahi-daemon[8016]: Withdrawing address record for 169.254.6.125 on ath0.
May 11 15:38:32 ubuntu avahi-daemon[8016]: Leaving mDNS multicast group on interface ath0.IPv4 with address 169.254.6.125.
May 11 15:38:32 ubuntu avahi-daemon[8016]: Interface ath0.IPv4 no longer relevant for mDNS.
May 11 15:38:32 ubuntu avahi-daemon[8016]: Withdrawing address record for fe80::214:a4ff:fe36:966e on ath0.
May 11 15:38:33 ubuntu avahi-autoipd(ath0)[9154]: SIOCSIFFLAGS failed: Permission denied
May 11 15:38:33 ubuntu avahi-autoipd(ath0)[9154]: Callout STOP, address 169.254.6.125 on interface ath0
May 11 15:38:33 ubuntu avahi-autoipd(ath0)[9155]: client: RTNETLINK answers: Cannot assign requested address
May 11 15:38:33 ubuntu avahi-autoipd(ath0)[9155]: Script execution failed with return value 2
May 11 15:38:37 ubuntu kernel: [ 1018.143963] ADDRCONF(NETDEV_UP): ath0: link is not ready
========================