Re: [ck] [ANNOUNCE] Staircase Deadline cpu scheduler version 0.46



On Wed, 09 May 2007 17:28:41 -0400
Dan Williams <dcbw redhat com> wrote:
> 
> I've seen this _once_ before on an OLPC machine, but it was intermittent
> and I was not able to debug it all the way down.  If you can reproduce
> reliably, try running "dbus-monitor --system" and try to get it to
> reproduce, then save the output from dbus-monitor and send it along to
> the list.
> 
> Thanks,
> Dan
> 

Okay, finally got round to doing that. I can now reproduce the problem
with the up and coming CFS scheduler v12 (apparently with or without
its 'old yield behaviour' feature. Here are some logs, one of a working
negotiation, and one of the (more common) failing case.

Working:
signal sender=org.freedesktop.DBus -> dest=:1.245 path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameAcquired
   string ":1.245"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceRemoved
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceAdded
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceCarrierOn
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.14 -> dest=(null destination) path=/org/freedesktop/NetworkManagerInfo; interface=org.freedesktop.NetworkManagerInfo; member=UserInterfaceActivated
signal sender=:1.14 -> dest=(null destination) path=/org/freedesktop/NetworkManagerInfo; interface=org.freedesktop.NetworkManagerInfo; member=UserInterfaceActivated
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 1
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 1
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 2
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 2
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivating
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.219 -> dest=(null destination) path=/com/redhat/dhcp; interface=com.redhat.dhcp.state; member=eth0
   byte 12
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.246"
   string ""
   string ":1.246"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.246"
   string ":1.246"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.247"
   string ""
   string ":1.247"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.247"
   string ":1.247"
   string ""
signal sender=:1.219 -> dest=(null destination) path=/com/redhat/dhcp; interface=com.redhat.dhcp.state; member=eth0
   byte 2
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 5
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 6
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string "org.freedesktop.Avahi"
   string ":1.187"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.187"
   string ":1.187"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.193"
   string ":1.193"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.248"
   string ""
   string ":1.248"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.249"
   string ""
   string ":1.249"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string "org.freedesktop.Avahi"
   string ""
   string ":1.249"
signal sender=:1.249 -> dest=(null destination) path=/; interface=org.freedesktop.Avahi.Server; member=StateChanged
   int32 1
   string "org.freedesktop.Avahi.Success"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 7
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 3
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceNowActive
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.249 -> dest=(null destination) path=/; interface=org.freedesktop.Avahi.Server; member=StateChanged
   int32 2
   string "org.freedesktop.Avahi.Success"

syslog for working case:
...
May 17 11:45:50 joker NetworkManager: <info>  Enabling networking.
May 17 11:45:50 joker NetworkManager: <info>  Deactivating device eth0.
May 17 11:45:50 joker via-rhine: Reset not complete yet. Trying harder.
May 17 11:45:50 joker eth0: link up, 10Mbps, half-duplex, lpa 0x0021
May 17 11:45:50 joker NetworkManager: <info>  eth0: Device is fully-supported using driver 'via-rhine'.
May 17 11:45:50 joker NetworkManager: <info>  nm_device_init(): waiting for device's worker thread to start
May 17 11:45:50 joker NetworkManager: <info>  nm_device_init(): device's worker thread started, continuing.
May 17 11:45:50 joker NetworkManager: <info>  Now managing wired Ethernet (802.3) device 'eth0'.
May 17 11:45:50 joker NetworkManager: <info>  Deactivating device eth0.
May 17 11:45:50 joker NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link.
May 17 11:45:52 joker NetworkManager: <info>  User Switch: /org/freedesktop/NetworkManager/Devices/eth0
May 17 11:45:52 joker NetworkManager: <info>  Deactivating device eth0.
May 17 11:45:52 joker NetworkManager: <info>  Device eth0 activation scheduled...
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) started...
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started...
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting...
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful.
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete.
May 17 11:45:52 joker NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
May 17 11:45:54 joker NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction.
May 17 11:45:54 joker NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
May 17 11:45:54 joker NetworkManager: <info>  DHCP daemon state is now 12 (successfully started) for interface eth0
May 17 11:45:54 joker NetworkManager: <info>  DHCP daemon state is now 1 (starting) for interface eth0
May 17 11:45:55 joker dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 3
May 17 11:45:55 joker dhclient: DHCPOFFER from 129.234.219.254
May 17 11:45:55 joker dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
May 17 11:45:55 joker dhclient: DHCPACK from 129.234.219.254
May 17 11:45:55 joker dhclient: bound to 129.234.219.68 -- renewal in 5452 seconds.
May 17 11:45:55 joker NetworkManager: <info>  DHCP daemon state is now 2 (bound) for interface eth0
May 17 11:45:55 joker NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) scheduled...
May 17 11:45:55 joker NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) started...
May 17 11:45:55 joker dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_domain
May 17 11:45:55 joker NetworkManager: <info>  Retrieved the following IP4 configuration from the DHCP daemon:
May 17 11:45:55 joker NetworkManager: <info>    address 129.234.219.68
May 17 11:45:55 joker NetworkManager: <info>    netmask 255.255.255.0
May 17 11:45:55 joker NetworkManager: <info>    broadcast 129.234.219.255
May 17 11:45:55 joker NetworkManager: <info>    gateway 129.234.219.254
May 17 11:45:55 joker NetworkManager: <info>    nameserver 129.234.4.13
May 17 11:45:55 joker NetworkManager: <info>    nameserver 129.234.4.9
May 17 11:45:55 joker NetworkManager: <info>    hostname '0-b-6a-99-27-12'
May 17 11:45:55 joker NetworkManager: <info>    domain name 'un.esol.dur.ac.uk'
May 17 11:45:55 joker NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled...
May 17 11:45:55 joker dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_servers
May 17 10:45:55 joker avahi-daemon[6203]: Joining mDNS multicast group on interface eth0.IPv4 with address 129.234.219.68.
May 17 10:45:55 joker avahi-daemon[6203]: New relevant interface eth0.IPv4 for mDNS.
May 17 10:45:55 joker avahi-daemon[6203]: Registering new address record for 129.234.219.68 on eth0.IPv4.
May 17 11:45:55 joker NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) complete.
May 17 11:45:55 joker NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) started...
...etc


######################################################################


Not working (dhcp daemon successfully negotiates a connection, but NM doesn't notice):
signal sender=org.freedesktop.DBus -> dest=:1.258 path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameAcquired
   string ":1.258"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceRemoved
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceAdded
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceCarrierOn
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.14 -> dest=(null destination) path=/org/freedesktop/NetworkManagerInfo; interface=org.freedesktop.NetworkManagerInfo; member=UserInterfaceActivated
signal sender=:1.14 -> dest=(null destination) path=/org/freedesktop/NetworkManagerInfo; interface=org.freedesktop.NetworkManagerInfo; member=UserInterfaceActivated
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 1
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 1
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 2
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 4
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 2
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivating
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.219 -> dest=(null destination) path=/com/redhat/dhcp; interface=com.redhat.dhcp.state; member=eth0
   byte 12
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.259"
   string ""
   string ":1.259"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.259"
   string ":1.259"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.260"
   string ""
   string ":1.260"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.260"
   string ":1.260"
   string ""
signal sender=:1.219 -> dest=(null destination) path=/com/redhat/dhcp; interface=com.redhat.dhcp.state; member=eth0
   byte 14
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.261"
   string ""
   string ":1.261"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.261"
   string ":1.261"
   string ""
signal sender=:1.219 -> dest=(null destination) path=/com/redhat/dhcp; interface=com.redhat.dhcp.state; member=eth0
   byte 14
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 5
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 6
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string "org.freedesktop.Avahi"
   string ":1.249"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.249"
   string ":1.249"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.256"
   string ":1.256"
   string ""
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.262"
   string ""
   string ":1.262"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string ":1.263"
   string ""
   string ":1.263"
signal sender=org.freedesktop.DBus -> dest=(null destination) path=/org/freedesktop/DBus; interface=org.freedesktop.DBus; member=NameOwnerChanged
   string "org.freedesktop.Avahi"
   string ""
   string ":1.263"
signal sender=:1.263 -> dest=(null destination) path=/; interface=org.freedesktop.Avahi.Server; member=StateChanged
   int32 1
   string "org.freedesktop.Avahi.Success"
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceActivationStage
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
   uint32 7
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=StateChange
   uint32 3
signal sender=:1.5 -> dest=(null destination) path=/org/freedesktop/NetworkManager; interface=org.freedesktop.NetworkManager; member=DeviceNowActive
   object path "/org/freedesktop/NetworkManager/Devices/eth0"
signal sender=:1.263 -> dest=(null destination) path=/; interface=org.freedesktop.Avahi.Server; member=StateChanged
   int32 2
   string "org.freedesktop.Avahi.Success"

syslog for not working case:
...
May 17 11:41:54 joker NetworkManager: <info>  Enabling networking.
May 17 11:41:54 joker NetworkManager: <info>  Deactivating device eth0.
May 17 11:41:54 joker via-rhine: Reset not complete yet. Trying harder.
May 17 11:41:54 joker eth0: link up, 10Mbps, half-duplex, lpa 0x0021
May 17 11:41:54 joker NetworkManager: <info>  eth0: Device is fully-supported using driver 'via-rhine'.
May 17 11:41:54 joker NetworkManager: <info>  nm_device_init(): waiting for device's worker thread to start
May 17 11:41:54 joker NetworkManager: <info>  nm_device_init(): device's worker thread started, continuing.
May 17 11:41:54 joker NetworkManager: <info>  Now managing wired Ethernet (802.3) device 'eth0'.
May 17 11:41:54 joker NetworkManager: <info>  Deactivating device eth0.
May 17 11:41:54 joker NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link.
May 17 11:41:58 joker NetworkManager: <info>  User Switch: /org/freedesktop/NetworkManager/Devices/eth0
May 17 11:41:58 joker NetworkManager: <info>  Deactivating device eth0.
May 17 11:41:58 joker NetworkManager: <info>  Device eth0 activation scheduled...
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) started...
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started...
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting...
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful.
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete.
May 17 11:41:58 joker NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
May 17 11:42:00 joker NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction.
May 17 11:42:00 joker NetworkManager: <info>  DHCP daemon state is now 12 (successfully started) for interface eth0
May 17 11:42:00 joker NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
May 17 11:42:01 joker dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4
May 17 11:42:01 joker dhclient: DHCPOFFER from 129.234.219.254
May 17 11:42:01 joker dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
May 17 11:42:01 joker dhclient: DHCPACK from 129.234.219.254
May 17 11:42:01 joker dhclient: bound to 129.234.219.68 -- renewal in 6802 seconds.
May 17 11:42:45 joker NetworkManager: <info>  Device 'eth0' DHCP transaction took too long (>45s), stopping it.
May 17 11:42:45 joker dhclient: There is already a pid file /var/run/dhclient-eth0.pid with pid 6156
May 17 11:42:45 joker dhclient: killed old client process, removed PID file
May 17 11:42:45 joker dhclient: DHCPRELEASE on eth0 to 129.234.4.86 port 67
May 17 11:42:45 joker dhclient: send_packet: Network is unreachable
May 17 11:42:45 joker dhclient: send_packet: please consult README file regarding broadcast address.
May 17 11:42:46 joker NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) scheduled...
May 17 11:42:46 joker NetworkManager: <info>  DHCP daemon state is now 14 (normal exit) for interface eth0
May 17 11:42:46 joker NetworkManager: <info>  DHCP daemon state is now 14 (normal exit) for interface eth0
May 17 11:42:46 joker NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) started...
May 17 11:42:46 joker NetworkManager: <info>  No DHCP reply received.  Automatically obtaining IP via Zeroconf.
May 17 11:42:46 joker NetworkManager: <info>  autoip: Sending probe #0 for IP address 169.254.157.128.
..etc



[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]