Comment 98 for bug 121439

Revision history for this message
Franck (alci) wrote :

I think the problem might be linked with bug number 128116. What makes me think so is that while nm is trying to connect (until it times out), latest info displayed in daemon.log is :

Aug 12 14:49:18 franck-gusty NetworkManager: <info> Activation (eth1) Stage 2 of 5 (Device Configure) complete.
Aug 12 14:49:23 franck-gusty NetworkManager: <info> nm_policy_device_change_check:: old_dev has_link? 1
Aug 12 14:49:23 franck-gusty NetworkManager: <info> Old device 'eth1' activating, won't change.

Then, if I switch wireless radio on and off, nm will connect, and here is what it says next :

Aug 12 14:50:02 franck-gusty NetworkManager: <debug> [1186923002.350925] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/usb_device_44e_300d_019c0ec2_if2').
Aug 12 14:50:02 franck-gusty hcid[5385]: Device hci0 has been activated
Aug 12 14:50:02 franck-gusty NetworkManager: <debug> [1186923002.369241] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/usb_device_44e_300d_019c0ec2_if0').
Aug 12 14:50:02 franck-gusty NetworkManager: <debug> [1186923002.379087] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/usb_device_44e_300d_019c0ec2_if0_bluetooth_hci').
Aug 12 14:50:02 franck-gusty NetworkManager: <debug> [1186923002.409693] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/usb_device_44e_300d_019c0ec2_if1').
Aug 12 14:50:02 franck-gusty NetworkManager: <debug> [1186923002.440255] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/usb_device_44e_300d_019c0ec2_usbraw').
Aug 12 14:50:07 franck-gusty NetworkManager: <info> nm_device_set_active_link start
Aug 12 14:50:07 franck-gusty NetworkManager: <info> Activation (eth1/wireless) Stage 2 of 5 (Device Configure) successful. Connected to access point 'fougeres'.
Aug 12 14:50:07 franck-gusty NetworkManager: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Aug 12 14:50:07 franck-gusty NetworkManager: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) started...
Aug 12 14:50:08 franck-gusty NetworkManager: <info> Activation (eth1) Beginning DHCP transaction.
Aug 12 14:50:08 franck-gusty NetworkManager: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) complete.
Aug 12 14:50:08 franck-gusty NetworkManager: <info> DHCP daemon state is now 12 (successfully started) for interface eth1
Aug 12 14:50:09 franck-gusty NetworkManager: <info> DHCP daemon state is now 1 (starting) for interface eth1
Aug 12 14:50:12 franck-gusty NetworkManager: <info> DHCP daemon state is now 4 (reboot) for interface eth1
Aug 12 14:50:12 franck-gusty NetworkManager: <info> Activation (eth1) Stage 4 of 5 (IP Configure Get) scheduled...
Aug 12 14:50:12 franck-gusty NetworkManager: <info> Activation (eth1) Stage 4 of 5 (IP Configure Get) started...
Aug 12 14:50:12 franck-gusty NetworkManager: <info> Retrieved the following IP4 configuration from the DHCP daemon:
Aug 12 14:50:12 franck-gusty NetworkManager: <info> address 192.168.0.5
Aug 12 14:50:12 franck-gusty NetworkManager: <info> netmask 255.255.255.0
Aug 12 14:50:12 franck-gusty NetworkManager: <info> broadcast 192.168.0.255
Aug 12 14:50:12 franck-gusty NetworkManager: <info> gateway 192.168.0.1
Aug 12 14:50:12 franck-gusty NetworkManager: <info> nameserver 192.168.0.1
Aug 12 14:50:12 franck-gusty NetworkManager: <info> domain name 'Belkin'
Aug 12 14:50:12 franck-gusty NetworkManager: <info> Activation (eth1) Stage 5 of 5 (IP Configure Commit) scheduled...
Aug 12 14:50:12 franck-gusty NetworkManager: <info> Activation (eth1) Stage 4 of 5 (IP Configure Get) complete.
Aug 12 14:50:12 franck-gusty NetworkManager: <info> Activation (eth1) Stage 5 of 5 (IP Configure Commit) started...

Does it help ?