I change loglevel of sshd, restart the machine and I think I've got him!

The problem is start sequence, the sshd starts before dhcp finishes
procedure of getting IP address from router (the standard BT broadband
router).

Please compare following lines from 
/var/log/auth:

Jul 22 21:35:05 madryt sshd[5612]: debug1: Bind to port 22 on 192.168.1.66.
Jul 22 21:35:05 madryt sshd[5612]: error: Bind to port 22 on 192.168.1.66 
failed: Cannot assign requested address.
Jul 22 21:35:05 madryt sshd[5612]: debug1: Bind to port 22 on 127.0.0.1.
Jul 22 21:35:05 madryt sshd[5612]: Server listening on 127.0.0.1 port 22.


and
/var/log/syslog:

Jul 22 21:35:13 madryt dhclient: DHCPREQUEST of 192.168.1.66 on eth0 to 
255.255.255.255 port 67
Jul 22 21:35:13 madryt dhclient: DHCPACK of 192.168.1.66 from 192.168.1.254
Jul 22 21:35:13 madryt avahi-daemon[5633]: Joining mDNS multicast group on 
interface eth0.IPv4 with address 192.168.1.66.
Jul 22 21:35:13 madryt avahi-daemon[5633]: New relevant interface eth0.IPv4 for 
mDNS.
Jul 22 21:35:13 madryt avahi-daemon[5633]: Registering new address record for 
192.168.1.66 on eth0.IPv4.
Jul 22 21:35:13 madryt kernel: [  137.075467] [drm] Initialized drm 1.1.0 
20060810
Jul 22 21:35:13 madryt kernel: [  137.125180] ACPI: PCI Interrupt 
0000:01:00.0[A] -> GSI 16 (level, low) -> IRQ 21
Jul 22 21:35:13 madryt kernel: [  137.125543] [drm] Initialized r128 2.5.0 
20030725 on minor 0
Jul 22 21:35:13 madryt kernel: [  137.127323] agpgart: Found an AGP 2.0 
compliant device at 0000:00:00.0.
Jul 22 21:35:13 madryt kernel: [  137.127364] agpgart: Putting AGP V2 device at 
0000:00:00.0 into 1x mode
Jul 22 21:35:13 madryt kernel: [  137.127389] agpgart: Putting AGP V2 device at 
0000:01:00.0 into 1x mode
Jul 22 21:35:13 madryt NetworkManager: <debug> [1216758913.209118] 
nm_hal_device_added(): New device added (hal udi is 
'/org/freedesktop/Hal/devices/pci_1002_5446_drm_r128_card0'). 
Jul 22 21:35:13 madryt NetworkManager: <info>  DHCP daemon state is now 4 
(reboot) for interface eth0 
Jul 22 21:35:13 madryt NetworkManager: <info>  Activation (eth0) Stage 4 of 5 
(IP Configure Get) scheduled... 
Jul 22 21:35:13 madryt NetworkManager: <info>  Activation (eth0) Stage 4 of 5 
(IP Configure Get) started... 
Jul 22 21:35:13 madryt dhcdbd: message_handler: message handler not found under 
/com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.host_name
Jul 22 21:35:13 madryt dhcdbd: message_handler: message handler not found under 
/com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_domain
Jul 22 21:35:13 madryt dhcdbd: message_handler: message handler not found under 
/com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_servers
Jul 22 21:35:13 madryt NetworkManager: <info>  Retrieved the following IP4 
configuration from the DHCP daemon: 
Jul 22 21:35:13 madryt NetworkManager: <info>    address 192.168.1.66 
Jul 22 21:35:13 madryt NetworkManager: <info>    netmask 255.255.255.0 
Jul 22 21:35:13 madryt NetworkManager: <info>    broadcast 192.168.1.255 
Jul 22 21:35:13 madryt NetworkManager: <info>    gateway 192.168.1.254 
Jul 22 21:35:13 madryt NetworkManager: <info>    nameserver 192.168.1.254 
Jul 22 21:35:13 madryt NetworkManager: <info>    domain name 'home' 
Jul 22 21:35:13 madryt dhcdbd: message_handler: message handler not found under 
/com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.interface_mtu
Jul 22 21:35:13 madryt NetworkManager: <info>  Activation (eth0) Stage 5 of 5 
(IP Configure Commit) scheduled... 
Jul 22 21:35:13 madryt NetworkManager: <info>  Activation (eth0) Stage 4 of 5 
(IP Configure Get) complete. 
Jul 22 21:35:13 madryt NetworkManager: <info>  Activation (eth0) Stage 5 of 5 
(IP Configure Commit) started... 
Jul 22 21:35:13 madryt dhclient: bound to 192.168.1.66 -- renewal in 32709 
seconds.
Jul 22 21:35:13 madryt kernel: [  137.252041] NET: Registered protocol family 10
Jul 22 21:35:13 madryt kernel: [  137.253010] lo: Disabled Privacy Extensions
Jul 22 21:35:13 madryt avahi-daemon[5633]: Withdrawing address record for 
192.168.1.66 on eth0.
Jul 22 21:35:13 madryt avahi-daemon[5633]: Leaving mDNS multicast group on 
interface eth0.IPv4 with address 192.168.1.66.
Jul 22 21:35:13 madryt avahi-daemon[5633]: Interface eth0.IPv4 no longer 
relevant for mDNS.
Jul 22 21:35:13 madryt avahi-daemon[5633]: Joining mDNS multicast group on 
interface eth0.IPv4 with address 192.168.1.66.
Jul 22 21:35:13 madryt avahi-daemon[5633]: New relevant interface eth0.IPv4 for 
mDNS.
Jul 22 21:35:13 madryt avahi-daemon[5633]: Registering new address record for 
192.168.1.66 on eth0.IPv4.

-- 
sshd doesn't start properly
https://bugs.launchpad.net/bugs/241796
You received this bug notification because you are a member of Ubuntu
Server Team, which is subscribed to openssh in ubuntu.

-- 
Ubuntu-server-bugs mailing list
Ubuntu-server-bugs@lists.ubuntu.com
Modify settings or unsubscribe at: 
https://lists.ubuntu.com/mailman/listinfo/ubuntu-server-bugs

Reply via email to