Log of NetworkManager 0.8-r1 Working Properly

networkmanager-0.8-r1-log (text/plain), 11.52 KB, created by Nick Andrade on 2010-07-29 08:57:48 UTC

Jul 29 01:41:46 bart NetworkManager[21540]: <info> caught signal 15, shutting down normally.
Jul 29 01:41:46 bart NetworkManager[21540]: <info> (eth0): cleaning up...
Jul 29 01:41:46 bart NetworkManager[21540]: <info> (eth0): taking down device.
Jul 29 01:41:46 bart NetworkManager[21540]: <info> (wlan0): taking down device.
Jul 29 01:41:46 bart avahi-daemon[6665]: Withdrawing address record for IPV6_ADDR_REMOVED on wlan0.
Jul 29 01:41:46 bart NetworkManager[21540]: <info> exiting (success)
Jul 29 01:41:46 bart NetworkManager: <info>  starting...
Jul 29 01:41:46 bart NetworkManager: <info>  modem-manager is now available
Jul 29 01:41:46 bart NetworkManager: Loaded plugin keyfile: (c) 2007 - 2008 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
Jul 29 01:41:46 bart NetworkManager: <info>  Found wlan radio killswitch rfkill0 (at /sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/ieee80211/phy0/rfkill0) (driver <unknown>)
Jul 29 01:41:46 bart NetworkManager: <info>  WiFi enabled by radio killswitch; enabled by state file
Jul 29 01:41:46 bart NetworkManager: <info>  WWAN enabled by radio killswitch; enabled by state file
Jul 29 01:41:46 bart NetworkManager: Ignoring insecure configuration file '/etc/NetworkManager/system-connections/.keep_net-misc_networkmanager-0'
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): carrier is OFF
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): new Ethernet device (driver: 'e1000e')
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): exported as /org/freedesktop/NetworkManager/Devices/0
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): now managed
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): device state change: 1 -> 2 (reason 2)
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): bringing up device.
Jul 29 01:41:46 bart kernel: [ 9803.185736] e1000e 0000:00:19.0: irq 30 for MSI/MSI-X
Jul 29 01:41:46 bart kernel: [ 9803.236949] e1000e 0000:00:19.0: irq 30 for MSI/MSI-X
Jul 29 01:41:46 bart kernel: [ 9803.238458] ADDRCONF(NETDEV_UP): eth0: link is not ready
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): preparing device.
Jul 29 01:41:46 bart NetworkManager: <info>  (eth0): deactivating device (reason: 2).
Jul 29 01:41:46 bart NetworkManager: Added default wired connection 'Auto eth0' for /sys/devices/pci0000:00/0000:00:19.0/net/eth0
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): driver supports SSID scans (scan_capa 0x01).
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): new 802.11 WiFi device (driver: 'iwlagn')
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): exported as /org/freedesktop/NetworkManager/Devices/1
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): now managed
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): device state change: 1 -> 2 (reason 2)
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): bringing up device.
Jul 29 01:41:46 bart kernel: [ 9803.274597] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): preparing device.
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): deactivating device (reason: 2).
Jul 29 01:41:46 bart NetworkManager: <WARN>  device_creator(): /sys/devices/virtual/net/vboxnet0: couldn't determine device driver; ignoring...
Jul 29 01:41:46 bart NetworkManager: <WARN>  default_adapter_cb(): bluez error getting default adapter: The name org.bluez was not provided by any .service files
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): supplicant interface state:  starting -> ready
Jul 29 01:41:46 bart NetworkManager: <info>  (wlan0): device state change: 2 -> 3 (reason 42)
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0) starting connection 'Auto OpenWrtN'
Jul 29 01:41:49 bart NetworkManager: <info>  (wlan0): device state change: 3 -> 4 (reason 0)
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jul 29 01:41:49 bart NetworkManager: <info>  (wlan0): device state change: 4 -> 5 (reason 0)
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0/wireless): access point 'Auto OpenWrtN' has security, but secrets are required.
Jul 29 01:41:49 bart NetworkManager: <info>  (wlan0): device state change: 5 -> 6 (reason 0)
Jul 29 01:41:49 bart NetworkManager: <info>  Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jul 29 01:41:50 bart NetworkManager: <info>  Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jul 29 01:41:50 bart NetworkManager: <info>  Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jul 29 01:41:50 bart NetworkManager: <info>  (wlan0): device state change: 6 -> 4 (reason 0)
Jul 29 01:41:50 bart NetworkManager: <info>  Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jul 29 01:41:50 bart NetworkManager: <info>  Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jul 29 01:41:50 bart NetworkManager: <info>  Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jul 29 01:41:50 bart NetworkManager: <info>  (wlan0): device state change: 4 -> 5 (reason 0)
Jul 29 01:41:50 bart NetworkManager: <info>  Activation (wlan0/wireless): connection 'Auto OpenWrtN' has security, and secrets exist.  No new secrets needed.
Jul 29 01:41:50 bart NetworkManager: <info>  Config: added 'ssid' value 'OpenWrtN'
Jul 29 01:41:50 bart NetworkManager: <info>  Config: added 'scan_ssid' value '1'
Jul 29 01:41:50 bart NetworkManager: <info>  Config: added 'key_mgmt' value 'WPA-PSK'
Jul 29 01:41:50 bart NetworkManager: <info>  Config: added 'psk' value '<omitted>'
Jul 29 01:41:50 bart NetworkManager: <info>  Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jul 29 01:41:50 bart NetworkManager: <info>  Config: set interface ap_scan to 1
Jul 29 01:41:50 bart NetworkManager: <info>  (wlan0): supplicant connection state:  inactive -> scanning
Jul 29 01:41:53 bart NetworkManager: <info>  (wlan0): supplicant connection state:  scanning -> associating
Jul 29 01:41:53 bart kernel: [ 9809.936361] wlan0: authenticate with MAC_ADDR_REMOVED (try 1)
Jul 29 01:41:53 bart kernel: [ 9810.136133] wlan0: authenticate with MAC_ADDR_REMOVED (try 2)
Jul 29 01:41:53 bart kernel: [ 9810.138361] wlan0: authenticated
Jul 29 01:41:53 bart kernel: [ 9810.138488] wlan0: associate with MAC_ADDR_REMOVED (try 1)
Jul 29 01:41:53 bart kernel: [ 9810.139886] wlan0: RX AssocResp from MAC_ADDR_REMOVED (capab=0x11 status=0 aid=1)
Jul 29 01:41:53 bart kernel: [ 9810.139893] wlan0: associated
Jul 29 01:41:53 bart kernel: [ 9810.144414] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jul 29 01:41:53 bart NetworkManager: <info>  (wlan0): supplicant connection state:  associating -> associated
Jul 29 01:41:53 bart NetworkManager: <info>  (wlan0): supplicant connection state:  associated -> 4-way handshake
Jul 29 01:41:53 bart NetworkManager: <info>  (wlan0): supplicant connection state:  4-way handshake -> group handshake
Jul 29 01:41:53 bart dhcpcd[9003]: wlan0: carrier acquired
Jul 29 01:41:53 bart NetworkManager: <info>  (wlan0): supplicant connection state:  group handshake -> completed
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'OpenWrtN'.
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Jul 29 01:41:53 bart NetworkManager: <info>  (wlan0): device state change: 5 -> 7 (reason 0)
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0) Beginning DHCP transaction (timeout in 45 seconds)
Jul 29 01:41:53 bart NetworkManager: <info>  dhcpcd started with pid 24598
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) started...
Jul 29 01:41:53 bart NetworkManager: <info>  Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) complete.
Jul 29 01:41:53 bart dhcpcd[24598]: version 5.2.6 starting
Jul 29 01:41:53 bart NetworkManager: <info>  DHCP: device wlan0 state changed (null) -> preinit
Jul 29 01:41:53 bart dhcpcd[24598]: wlan0: rebinding lease of 192.168.1.77
Jul 29 01:41:53 bart dhcpcd[9003]: wlan0: rebinding lease of 192.168.1.77
Jul 29 01:41:53 bart dhcpcd[24598]: wlan0: acknowledged 192.168.1.77 from 192.168.1.1
Jul 29 01:41:53 bart dhcpcd[9003]: wlan0: acknowledged 192.168.1.77 from 192.168.1.1
Jul 29 01:41:53 bart dhcpcd[24598]: wlan0: checking for 192.168.1.77
Jul 29 01:41:53 bart dhcpcd[9003]: wlan0: checking for 192.168.1.77
Jul 29 01:41:55 bart avahi-daemon[6665]: Registering new address record for IPV6_ADDR_REMOVED on wlan0.*.
Jul 29 01:41:58 bart dhcpcd[24598]: wlan0: leased 192.168.1.77 for 43200 seconds
Jul 29 01:41:58 bart avahi-daemon[6665]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.77.
Jul 29 01:41:58 bart avahi-daemon[6665]: New relevant interface wlan0.IPv4 for mDNS.
Jul 29 01:41:58 bart avahi-daemon[6665]: Registering new address record for 192.168.1.77 on wlan0.IPv4.
Jul 29 01:41:58 bart NetworkManager: <info>  DHCP: device wlan0 state changed preinit -> bound
Jul 29 01:41:58 bart NetworkManager: <info>  Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled...
Jul 29 01:41:58 bart NetworkManager: <info>  Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started...
Jul 29 01:41:58 bart NetworkManager: <info>    address 192.168.1.77
Jul 29 01:41:58 bart NetworkManager: <info>    prefix 24 (255.255.255.0)
Jul 29 01:41:58 bart NetworkManager: <info>    gateway 192.168.1.1
Jul 29 01:41:58 bart NetworkManager: <info>    hostname 'bart'
Jul 29 01:41:58 bart NetworkManager: <info>    nameserver '192.168.1.1'
Jul 29 01:41:58 bart NetworkManager: <info>    domain name 'lan'
Jul 29 01:41:58 bart NetworkManager: <info>  Activation (wlan0) Stage 5 of 5 (IP Configure Commit) scheduled...
Jul 29 01:41:58 bart NetworkManager: <info>  Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete.
Jul 29 01:41:58 bart NetworkManager: <info>  Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started...
Jul 29 01:41:58 bart dhcpcd[9003]: wlan0: leased 192.168.1.77 for 43200 seconds
Jul 29 01:41:58 bart dhcpcd[9003]: vboxnet0: add_route: Invalid argument
Jul 29 01:41:59 bart NetworkManager: <info>  Clearing nscd hosts cache.
Jul 29 01:41:59 bart NetworkManager: <info>  (wlan0): device state change: 7 -> 8 (reason 0)
Jul 29 01:41:59 bart NetworkManager: <info>  Clearing nscd hosts cache.
Jul 29 01:41:59 bart NetworkManager: <info>  Policy set 'Auto OpenWrtN' (wlan0) as default for routing and DNS.
Jul 29 01:41:59 bart NetworkManager: <info>  Activation (wlan0) successful, device activated.
Jul 29 01:41:59 bart NetworkManager: <info>  Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete.
Jul 29 01:42:04 bart kernel: [ 9820.711148] wlan0: no IPv6 routers present
Jul 29 01:43:05 bart NetworkManager: <info>  (wlan0): supplicant connection state:  completed -> group handshake
Jul 29 01:43:05 bart NetworkManager: <info>  (wlan0): supplicant connection state:  group handshake -> completed