Attachment 156795 Details for Bug 194124 – Syslog (with extra debug code)

Syslog (with extra debug code)

nm-syslog.txt (text/plain), 25.42 KB, created by Onno Witvliet on 2007-06-12 13:51:45 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Onno Witvliet

Created: 2007-06-12 13:51:45 UTC

Size: 25.42 KB

patch

obsolete

>After reboot (cable not connected)
>
>Jun 12 14:11:57 atlas dhcdbd: Started up.
>Jun 12 14:12:03 atlas NetworkManager: <info>  starting... 
>Jun 12 14:12:03 atlas kernel: ADDRCONF(NETDEV_UP): eth0: link is not ready
>Jun 12 14:12:04 atlas NetworkManager: <info>  eth0: Device is fully-supported using driver 'tg3'. 
>Jun 12 14:12:04 atlas NetworkManager: <info>  nm_device_init(): waiting for device's worker thread to start 
>Jun 12 14:12:04 atlas NetworkManager: <info>  nm_device_init(): device's worker thread started, continuing. 
>Jun 12 14:12:05 atlas NetworkManager: <info>  Now managing wired Ethernet (802.3) device 'eth0'. 
>Jun 12 14:12:05 atlas NetworkManager: <info>  Deactivating device eth0. 
>Jun 12 14:12:06 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 14:12:06 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_deactivated_helper (129) device eth0 will set active link to FALSE 
>Jun 12 14:12:06 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 14:12:06 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 1 
>Jun 12 14:12:07 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_activated_helper (102) device eth0 will set active link to TRUE 
>Jun 12 14:12:07 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 1 
>Jun 12 14:12:07 atlas NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link. 
>Jun 12 14:12:07 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_activated (122) device eth0 scheduled link_activated_helper 
>Jun 12 14:12:07 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 1 
>Jun 12 14:12:08 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_activated (122) device eth0 scheduled link_activated_helper 
>Jun 12 14:12:08 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 14:12:08 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 14:12:08 atlas NetworkManager: <info>  SWITCH: no current connection, found better connection 'eth0'. 
>Jun 12 14:12:09 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_activated_helper (102) device eth0 will set active link to TRUE 
>Jun 12 14:12:09 atlas dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.reason
>Jun 12 14:12:09 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_deactivated_helper (129) device eth0 will set active link to FALSE 
>Jun 12 14:12:10 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 0 
>Jun 12 14:12:10 atlas NetworkManager: <info>  Will activate connection 'eth0'. 
>Jun 12 14:12:11 atlas NetworkManager: <info>  Device eth0 activation scheduled... 
>Jun 12 14:12:12 atlas NetworkManager: <info>  Activation (eth0) started... 
>Jun 12 14:12:12 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled... 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started... 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled... 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete. 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting... 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful. 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled. 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete. 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started... 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction. 
>Jun 12 14:12:13 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete. 
>Jun 12 14:12:13 atlas NetworkManager: <info>  DHCP daemon state is now 12 (successfully started) for interface eth0 
>Jun 12 14:12:13 atlas NetworkManager: <info>  DHCP daemon state is now 1 (starting) for interface eth0 
>Jun 12 14:12:13 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 3
>Jun 12 14:12:16 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7
>Jun 12 14:12:23 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 8
>Jun 12 14:12:27 atlas NetworkManager: <info>  Updating allowed wireless network lists. 
>Jun 12 14:12:28 atlas NetworkManager: <WARN>  nm_dbus_get_networks_cb(): error received: org.freedesktop.NetworkManagerInfo.NoNetworks - There are no wireless networks stored.. 
>Jun 12 14:12:31 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 15
>Jun 12 14:12:46 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 9
>Jun 12 14:12:55 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 15
>Jun 12 14:12:58 atlas NetworkManager: <info>  Device 'eth0' DHCP transaction took too long (>45s), stopping it. 
>Jun 12 14:12:58 atlas dhclient: DHCPRELEASE on eth0 to 10.1.1.1 port 67
>Jun 12 14:12:58 atlas dhclient: send_packet: Network is unreachable
>Jun 12 14:12:58 atlas dhclient: send_packet: please consult README file regarding broadcast address.
>Jun 12 14:12:59 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) scheduled... 
>Jun 12 14:12:59 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) started... 
>Jun 12 14:12:59 atlas NetworkManager: <info>  No DHCP reply received.  Automatically obtaining IP via Zeroconf. 
>Jun 12 14:12:59 atlas NetworkManager: <info>  DHCP daemon state is now 14 (normal exit) for interface eth0 
>Jun 12 14:12:59 atlas NetworkManager: <info>  DHCP daemon state is now 11 (unknown) for interface eth0 
>Jun 12 14:12:59 atlas NetworkManager: <info>  DHCP daemon state is now 14 (normal exit) for interface eth0 
>Jun 12 14:12:59 atlas NetworkManager: <info>  autoip: Sending probe #0 for IP address 169.254.230.103. 
>Jun 12 14:12:59 atlas NetworkManager: <info>  autoip: Waiting for reply... 
>Jun 12 14:13:01 atlas NetworkManager: <info>  autoip: Sending probe #1 for IP address 169.254.230.103. 
>Jun 12 14:13:01 atlas NetworkManager: <info>  autoip: Waiting for reply... 
>Jun 12 14:13:03 atlas NetworkManager: <info>  autoip: Sending probe #2 for IP address 169.254.230.103. 
>Jun 12 14:13:03 atlas NetworkManager: <info>  autoip: Waiting for reply... 
>Jun 12 14:13:06 atlas NetworkManager: <info>  autoip: Sending announce #0 for IP address 169.254.230.103. 
>Jun 12 14:13:06 atlas NetworkManager: <info>  autoip: Waiting for reply... 
>Jun 12 14:13:09 atlas NetworkManager: <info>  autoip: Sending announce #1 for IP address 169.254.230.103. 
>Jun 12 14:13:09 atlas NetworkManager: <info>  autoip: Waiting for reply... 
>Jun 12 14:13:12 atlas NetworkManager: <info>  autoip: Sending announce #2 for IP address 169.254.230.103. 
>Jun 12 14:13:12 atlas NetworkManager: <info>  autoip: Waiting for reply... 
>Jun 12 14:13:15 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled... 
>Jun 12 14:13:15 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) complete. 
>Jun 12 14:13:15 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) started... 
>Jun 12 14:13:16 atlas NetworkManager: <info>  Activation (eth0) successful, device activated. 
>Jun 12 14:13:16 atlas NetworkManager: <info>  Activation (eth0) Finish handler scheduled. 
>Jun 12 14:13:16 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete. 
>
>Plug in cable:
>Jun 12 14:16:29 atlas kernel: tg3: eth0: Link is up at 100 Mbps, full duplex.
>Jun 12 14:16:29 atlas kernel: tg3: eth0: Flow control is off for TX and off for RX.
>Jun 12 14:16:29 atlas kernel: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>Jun 12 14:16:29 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 1 
>Jun 12 14:16:29 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_activated (122) device eth0 scheduled link_activated_helper 
>Jun 12 14:16:29 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_activated_helper (102) device eth0 will set active link to TRUE 
>Jun 12 14:16:29 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 1 
>
>
>Unplug cable: (doesn't release IP address)
>Jun 12 14:19:47 atlas kernel: tg3: eth0: Link is down.
>Jun 12 14:19:47 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 14:19:47 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 14:19:47 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_deactivated_helper (129) device eth0 will set active link to FALSE 
>Jun 12 14:19:47 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 0 
>Jun 12 14:19:47 atlas NetworkManager: <info>  SWITCH: terminating current connection 'eth0' because it's no longer valid. 
>Jun 12 14:19:47 atlas NetworkManager: <info>  Deactivating device eth0. 
>Jun 12 14:19:47 atlas NetworkManager: nm_device_is_802_3_ethernet: assertion `dev != NULL' failed
>Jun 12 14:19:47 atlas NetworkManager: nm_device_is_802_11_wireless: assertion `dev != NULL' failed
>
>Plug in cable: (brings up link successfully)
>Jun 12 14:20:24 atlas kernel: tg3: eth0: Link is up at 100 Mbps, full duplex.
>Jun 12 14:20:24 atlas kernel: tg3: eth0: Flow control is off for TX and off for RX.
>Jun 12 14:20:24 atlas kernel: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>Jun 12 14:20:24 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 1 
>Jun 12 14:20:24 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_activated (122) device eth0 scheduled link_activated_helper 
>Jun 12 14:20:24 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_activated_helper (102) device eth0 will set active link to TRUE 
>Jun 12 14:20:24 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 1 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link. 
>Jun 12 14:20:24 atlas NetworkManager: <info>  SWITCH: no current connection, found better connection 'eth0'. 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Will activate connection 'eth0'. 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Device eth0 activation scheduled... 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) started... 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled... 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started... 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled... 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete. 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting... 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful. 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled. 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete. 
>Jun 12 14:20:24 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started... 
>Jun 12 14:20:25 atlas NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction. 
>Jun 12 14:20:25 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete. 
>Jun 12 14:20:25 atlas NetworkManager: <info>  DHCP daemon state is now 12 (successfully started) for interface eth0 
>Jun 12 14:20:25 atlas NetworkManager: <info>  DHCP daemon state is now 1 (starting) for interface eth0 
>Jun 12 14:20:25 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 6
>Jun 12 14:20:25 atlas dhclient: DHCPOFFER from 10.1.1.1
>Jun 12 14:20:25 atlas dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
>Jun 12 14:20:25 atlas dhclient: DHCPACK from 10.1.1.1
>Jun 12 14:20:25 atlas NetworkManager: <info>  DHCP daemon state is now 2 (bound) for interface eth0 
>Jun 12 14:20:25 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) scheduled... 
>Jun 12 14:20:25 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) started... 
>Jun 12 14:20:25 atlas dhclient: bound to 10.1.1.133 -- renewal in 38512 seconds.
>Jun 12 14:20:25 atlas dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.host_name
>Jun 12 14:20:25 atlas dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_domain
>Jun 12 14:20:25 atlas dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_servers
>Jun 12 14:20:25 atlas NetworkManager: <info>  Retrieved the following IP4 configuration from the DHCP daemon: 
>Jun 12 14:20:25 atlas NetworkManager: <info>    address 10.1.1.133 
>Jun 12 14:20:25 atlas NetworkManager: <info>    netmask 255.255.255.0 
>Jun 12 14:20:25 atlas NetworkManager: <info>    broadcast 10.1.1.255 
>Jun 12 14:20:25 atlas NetworkManager: <info>    gateway 10.1.1.1 
>Jun 12 14:20:25 atlas NetworkManager: <info>    nameserver 11.12.196.6 
>Jun 12 14:20:25 atlas NetworkManager: <info>    nameserver 11.12.192.6 
>Jun 12 14:20:25 atlas NetworkManager: <info>    domain name 'domainname' 
>Jun 12 14:20:25 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled... 
>Jun 12 14:20:25 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) complete. 
>Jun 12 14:20:25 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) started... 
>Jun 12 14:20:26 atlas NetworkManager: <info>  Activation (eth0) Finish handler scheduled. 
>Jun 12 14:20:26 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete. 
>Jun 12 14:20:26 atlas NetworkManager: <info>  Activation (eth0) successful, device activated. 
>
>Unplug cable:
>Jun 12 14:20:45 atlas kernel: tg3: eth0: Link is down.
>Jun 12 14:20:45 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 14:20:45 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 14:20:45 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_deactivated_helper (129) device eth0 will set active link to FALSE 
>Jun 12 14:20:45 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 0 
>Jun 12 14:20:45 atlas NetworkManager: <info>  SWITCH: terminating current connection 'eth0' because it's no longer valid. 
>Jun 12 14:20:45 atlas NetworkManager: <info>  Deactivating device eth0. 
>Jun 12 14:20:45 atlas dhclient: DHCPRELEASE on eth0 to 10.1.1.1 port 67
>Jun 12 14:20:46 atlas NetworkManager: nm_device_is_802_3_ethernet: assertion `dev != NULL' failed
>Jun 12 14:20:46 atlas NetworkManager: nm_device_is_802_11_wireless: assertion `dev != NULL' failed
>
>Plug in cable: (NO DHCP! etc)
>Jun 12 14:20:56 atlas kernel: tg3: eth0: Link is up at 100 Mbps, full duplex.
>Jun 12 14:20:56 atlas kernel: tg3: eth0: Flow control is off for TX and off for RX.
>Jun 12 14:20:56 atlas kernel: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>Jun 12 14:20:56 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 1 
>Jun 12 14:20:56 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_activated (122) device eth0 scheduled link_activated_helper 
>Jun 12 14:20:56 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_activated_helper (102) device eth0 will set active link to TRUE 
>Jun 12 14:20:56 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 1 
>Jun 12 14:20:56 atlas NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link. 
>
>Unplug cable:
>Jun 12 15:03:14 atlas kernel: tg3: eth0: Link is down.
>Jun 12 15:03:14 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 15:03:14 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 15:03:14 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_deactivated_helper (129) device eth0 will set active link to FALSE 
>Jun 12 15:03:14 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 0 
>
>Plug in cable: (still no DHCP etc)
>Jun 12 15:03:33 atlas kernel: tg3: eth0: Link is up at 100 Mbps, full duplex.
>Jun 12 15:03:33 atlas kernel: tg3: eth0: Flow control is off for TX and off for RX.
>Jun 12 15:03:33 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 1 
>Jun 12 15:03:33 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_activated (122) device eth0 scheduled link_activated_helper 
>Jun 12 15:03:33 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_activated_helper (102) device eth0 will set active link to TRUE 
>Jun 12 15:03:33 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 1 
>Jun 12 15:03:33 atlas NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link. 
>
>
>Restart NetworkManager: (to get working connection)
>
>Jun 12 15:31:48 atlas NetworkManager: <info>  starting... 
>Jun 12 15:31:48 atlas kernel: ADDRCONF(NETDEV_UP): eth0: link is not ready
>Jun 12 15:31:48 atlas NetworkManager: <info>  eth0: Device is fully-supported using driver 'tg3'. 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm_device_init(): waiting for device's worker thread to start 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm_device_init(): device's worker thread started, continuing. 
>Jun 12 15:31:48 atlas NetworkManager: <info>  Now managing wired Ethernet (802.3) device 'eth0'. 
>Jun 12 15:31:48 atlas NetworkManager: <info>  Deactivating device eth0. 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 0 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_deactivated (149) device eth0 scheduled link_deactivated_helper 
>Jun 12 15:31:48 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_deactivated_helper (129) device eth0 will set active link to FALSE 
>Jun 12 15:31:48 atlas NetworkManager: <info>  Updating allowed wireless network lists. 
>Jun 12 15:31:48 atlas NetworkManager: <WARN>  nm_dbus_get_networks_cb(): error received: org.freedesktop.NetworkManagerInfo.NoNetworks - There are no wireless networks stored.. 
>Jun 12 15:31:50 atlas kernel: tg3: eth0: Link is up at 100 Mbps, full duplex.
>Jun 12 15:31:50 atlas kernel: tg3: eth0: Flow control is off for TX and off for RX.
>Jun 12 15:31:50 atlas kernel: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>Jun 12 15:31:50 atlas NetworkManager: <info>  nm-netlink-monitor.c - nm_netlink_monitor_event_handler (724) netlink reports device eth0 link now 1 
>Jun 12 15:31:50 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - nm_device_802_3_ethernet_link_activated (122) device eth0 scheduled link_activated_helper 
>Jun 12 15:31:50 atlas NetworkManager: <info>  nm-device-802-3-ethernet.c - link_activated_helper (102) device eth0 will set active link to TRUE 
>Jun 12 15:31:50 atlas NetworkManager: <info>  nm-device.c - nm_device_set_active_link (596) device eth0 link state set to 1 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link. 
>Jun 12 15:31:50 atlas NetworkManager: <info>  SWITCH: no current connection, found better connection 'eth0'. 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Will activate connection 'eth0'. 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Device eth0 activation scheduled... 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) started... 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled... 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started... 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled... 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete. 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting... 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful. 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled. 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete. 
>Jun 12 15:31:50 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started... 
>Jun 12 15:31:51 atlas NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction. 
>Jun 12 15:31:51 atlas NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete. 
>Jun 12 15:31:51 atlas NetworkManager: <info>  DHCP daemon state is now 12 (successfully started) for interface eth0 
>Jun 12 15:31:51 atlas NetworkManager: <info>  DHCP daemon state is now 1 (starting) for interface eth0 
>Jun 12 15:31:51 atlas dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4
>Jun 12 15:31:51 atlas dhclient: DHCPOFFER from 10.1.1.1
>Jun 12 15:31:51 atlas dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
>Jun 12 15:31:51 atlas dhclient: DHCPACK from 10.1.1.1
>Jun 12 15:31:51 atlas NetworkManager: <info>  DHCP daemon state is now 2 (bound) for interface eth0 
>Jun 12 15:31:51 atlas dhclient: bound to 10.1.1.133 -- renewal in 36109 seconds.
>Jun 12 15:31:51 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) scheduled... 
>Jun 12 15:31:51 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) started... 
>Jun 12 15:31:51 atlas dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.host_name
>Jun 12 15:31:51 atlas dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_domain
>Jun 12 15:31:51 atlas dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_servers
>Jun 12 15:31:51 atlas NetworkManager: <info>  Retrieved the following IP4 configuration from the DHCP daemon: 
>Jun 12 15:31:51 atlas NetworkManager: <info>    address 10.1.1.133 
>Jun 12 15:31:51 atlas NetworkManager: <info>    netmask 255.255.255.0 
>Jun 12 15:31:51 atlas NetworkManager: <info>    broadcast 10.1.1.255 
>Jun 12 15:31:51 atlas NetworkManager: <info>    gateway 10.1.1.1 
>Jun 12 15:31:51 atlas NetworkManager: <info>    nameserver 11.12.196.6 
>Jun 12 15:31:51 atlas NetworkManager: <info>    nameserver 11.12.192.6 
>Jun 12 15:31:51 atlas NetworkManager: <info>    domain name 'domainname' 
>Jun 12 15:31:51 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled... 
>Jun 12 15:31:51 atlas NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) complete. 
>Jun 12 15:31:51 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) started... 
>Jun 12 15:31:52 atlas NetworkManager: <info>  Activation (eth0) successful, device activated. 
>Jun 12 15:31:52 atlas NetworkManager: <info>  Activation (eth0) Finish handler scheduled. 
>Jun 12 15:31:52 atlas NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete.

Actions: View

Attachments on bug 194124: 156795 | 157295 | 157301 | 157705