Hi Static IPs: Some friends have the same config working on a static network since some 2 years (Debian Etch IIRC). With karmic they report it's working as long as they use wicd: but they are unable to use NetworkManager (no logon servers). They are now planning to migrate all the school within a 2 months deadline so it seems they feel happy. I could get a syslog from them if needed.
DHCP: tried on another machine with samba package installed, so smbd and nmbd appear on syslog too. I tried the four combinations of lines/no lines about eth0 on /etc/network/interfaces and managed = false/true on /etc/NetworkManager/nm-system-settings.conf. Two of them (managed = false) follow below. I guess this covers the two usual scenarios. Behaviour is always the same in all four cases. No wicd tests done. It seems that, with any config, and even if everybody gets fired up just in time, dhclient does not finish before samba daemons start. I hope you can see the causes I'm unable to see. After some googling, it seems that there is a NETWORKWAIT option on RedHat that goes in /etc/network/interfaces equivalent, but I'm unable to see any mention about it on .deb-based distros. I know this is a samba bug report, but does anybody knows about it? Funniest thing is, if you wait some 30 seconds after gdm appears on screen, you can login at first attemp; if you don't wait, first login fails (?) Second login attempt always work. Syslog snippets follow, I could send corresponding samba logs with loglevel = 3 if needed. Best regards, Roman syslog snippet 0: eth0 lines on /etc/network/interfaces managed = false on /etc/NetworkManager/nm-system-settings.conf ============================================================== Jan 26 12:00:32 u034755 kernel: imklog 4.2.0, log source = /var/run/rsyslog/kmsg started. Jan 26 12:00:32 u034755 NetworkManager: <info> starting... Jan 26 12:00:32 u034755 NetworkManager: <info> Trying to start the modem-manager... Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: init! Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: update_system_hostname Jan 26 12:00:32 u034755 NetworkManager: SCPluginIfupdown: guessed connection type (eth0) = 802-3-ethernet Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: update_connection_setting_from_if_block: name:eth0, type:802-3-ethernet, id:Ifupdown (eth0), uuid: 681b428f-beaf-8932-dce4-687ed5bae28e Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: autoconnect Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Nokia Jan 26 12:00:32 u034755 NetworkManager: SCPluginIfupdown: management mode: unmanaged Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Sierra Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: devices added (path: /sys/devices/pci0000:00/0000:00:1c.4/0000:04:00.0/net/eth0, iface: eth0) Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Ericsson MBM Jan 26 12:00:32 u034755 NetworkManager: SCPluginIfupdown: locking wired connection setting Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Generic Jan 26 12:00:32 u034755 NetworkManager: Ifupdown: get unmanaged devices count: 1 Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Huawei Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: (155470576) ... get_connections. Jan 26 12:00:32 u034755 modem-manager: Loaded plugin ZTE Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: (155470576) ... get_connections (managed=false): return empty list. Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Option Jan 26 12:00:32 u034755 NetworkManager: Ifupdown: get unmanaged devices count : 1 Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Gobi Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/lo, iface: lo) Jan 26 12:00:32 u034755 modem-manager: Loaded plugin MotoC Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found. Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Option High-Speed Jan 26 12:00:32 u034755 NetworkManager: SCPlugin-Ifupdown: end _init. Jan 26 12:00:32 u034755 modem-manager: Loaded plugin Novatel Jan 26 12:00:32 u034755 NetworkManager: Loaded plugin ifupdown: (C) 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list. Jan 26 12:00:32 u034755 NetworkManager: Loaded plugin keyfile: (c) 2007 - 2008 Red Hat, Inc. To report bugs please use the NetworkManager mailing list. Jan 26 12:00:32 u034755 NetworkManager: <info> Wireless now enabled by radio killswitch Jan 26 12:00:32 u034755 NetworkManager: <info> (eth0): carrier is ON Jan 26 12:00:32 u034755 NetworkManager: <info> (eth0): new Ethernet device (driver: 'r8169') Jan 26 12:00:32 u034755 NetworkManager: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/0 Jan 26 12:00:32 u034755 kernel: [ 0.000000] Linux version 2.6.31-17-generic (bui...@palmer) (gcc version 4.4.1 (Ubuntu 4.4.1-4ubuntu8) ) #54-Ubuntu SMP Thu Dec 10 16:20:31 UTC 2009 (Ubuntu 2.6.31-17.54-generic) Jan 26 12:00:32 u034755 NetworkManager: <info> modem-manager is now available Jan 26 12:00:32 u034755 NetworkManager: <WARN> default_adapter_cb(): bluez error getting default adapter: The name org.bluez was not provided by any .service files Jan 26 12:00:32 u034755 NetworkManager: <info> Trying to start the supplicant... Jan 26 12:00:32 u034755 init: apport pre-start process (1117) terminated with status 1 Jan 26 12:00:32 u034755 cron[1138]: (CRON) INFO (pidfile fd = 3) Jan 26 12:00:32 u034755 anacron[1194]: Anacron 2.3 started on 2010-01-26 Jan 26 12:00:32 u034755 init: apport post-stop process (1163) terminated with status 1 Jan 26 12:00:32 u034755 cron[1198]: (CRON) STARTUP (fork ok) Jan 26 12:00:32 u034755 cron[1198]: (CRON) INFO (Running @reboot jobs) Jan 26 12:00:32 u034755 anacron[1194]: Normal exit (0 jobs run) Jan 26 12:00:33 u034755 dhclient: Listening on LPF/eth0/00:1f:d0:82:04:22 Jan 26 12:00:33 u034755 dhclient: Sending on LPF/eth0/00:1f:d0:82:04:22 Jan 26 12:00:33 u034755 dhclient: Sending on Socket/fallback Jan 26 12:00:33 u034755 dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 6 Jan 26 12:00:33 u034755 nmbd[1295]: [2010/01/26 12:00:33, 0] nmbd/nmbd_subnetdb.c:206(create_subnets) Jan 26 12:00:33 u034755 nmbd[1295]: create_subnets: No local IPv4 non-loopback interfaces ! Jan 26 12:00:33 u034755 nmbd[1295]: [2010/01/26 12:00:33, 0] nmbd/nmbd_subnetdb.c:207(create_subnets) Jan 26 12:00:33 u034755 nmbd[1295]: create_subnets: Waiting for an interface to appear ... Jan 26 12:00:33 u034755 smbd[1297]: [2010/01/26 12:00:33, 0] printing/print_cups.c:103(cups_connect) Jan 26 12:00:33 u034755 smbd[1297]: Unable to connect to CUPS server localhost:631 - Connection refused Jan 26 12:00:33 u034755 smbd[1299]: [2010/01/26 12:00:33, 0] printing/print_cups.c:103(cups_connect) Jan 26 12:00:33 u034755 smbd[1299]: Unable to connect to CUPS server localhost:631 - Connection refused Jan 26 12:00:33 u034755 smbd[1300]: [2010/01/26 12:00:33, 0] libsmb/nmblib.c:834(send_udp) Jan 26 12:00:33 u034755 smbd[1300]: Packet send failed to 10.16.15.1(137) ERRNO=Network is unreachable Jan 26 12:00:33 u034755 smbd[1300]: [2010/01/26 12:00:33, 0] printing/nt_printing.c:627(nt_printing_init) Jan 26 12:00:33 u034755 smbd[1300]: nt_printing_init: error checking published printers: WERR_ACCESS_DENIED Jan 26 12:00:33 u034755 smbd[1300]: [2010/01/26 12:00:33, 0] smbd/server.c:456(smbd_open_one_socket) Jan 26 12:00:33 u034755 smbd[1300]: smbd_open_once_socket: open_socket_in: Address already in use Jan 26 12:00:33 u034755 smbd[1300]: [2010/01/26 12:00:33, 0] smbd/server.c:456(smbd_open_one_socket) Jan 26 12:00:33 u034755 smbd[1300]: smbd_open_once_socket: open_socket_in: Address already in use Jan 26 12:00:33 u034755 winbindd[1339]: [2010/01/26 12:00:33, 0] winbindd/winbindd_cache.c:2578(initialize_winbindd_cache) Jan 26 12:00:33 u034755 winbindd[1339]: initialize_winbindd_cache: clearing cache and re-creating with version number 1 Jan 26 12:00:33 u034755 ntpd[1361]: ntpd 4.2....@1.1549-o Fri Dec 4 18:08:42 UTC 2009 (1) Jan 26 12:00:33 u034755 ntpd[1362]: precision = 1.000 usec Jan 26 12:00:33 u034755 ntpd[1362]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled Jan 26 12:00:33 u034755 ntpd[1362]: Listening on interface #1 wildcard, ::#123 Disabled Jan 26 12:00:33 u034755 ntpd[1362]: Listening on interface #2 lo, ::1#123 Enabled Jan 26 12:00:33 u034755 ntpd[1362]: bind() fd 19, family 10, port 123, scope 2 , addr fe80::21f:d0ff:fe82:422, in6_is_addr_multicast=0 flags=0x11 fails: Cannot assign requested address Jan 26 12:00:33 u034755 ntpd[1362]: unable to create socket on eth0 (3) for fe80::21f:d0ff:fe82:422#123 Jan 26 12:00:33 u034755 ntpd[1362]: failed to initialize interface for address fe80::21f:d0ff:fe82:422 Jan 26 12:00:33 u034755 ntpd[1362]: Listening on interface #4 lo, 127.0.0.1#123 Enabled Jan 26 12:00:33 u034755 ntpd[1362]: kernel time sync status 2040 Jan 26 12:00:33 u034755 ntpd[1362]: frequency initialized -31.871 PPM from /var/lib/ntp/ntp.drift Jan 26 12:00:33 u034755 ntpd[1362]: Warning: the "dynamic" keyword has been obsoleted and will be removed in the next release Jan 26 12:00:33 u034755 winbindd[1341]: [2010/01/26 12:00:33, 0] libsmb/nmblib.c:834(send_udp) Jan 26 12:00:33 u034755 winbindd[1341]: Packet send failed to 10.16.15.1(137) ERRNO=Network is unreachable Jan 26 12:00:33 u034755 dhclient: DHCPOFFER of 10.16.13.92 from 10.16.13.100 Jan 26 12:00:33 u034755 dhclient: DHCPREQUEST of 10.16.13.92 on eth0 to 255.255.255.255 port 67 Jan 26 12:00:33 u034755 dhclient: DHCPACK of 10.16.13.92 from 10.16.13.100 Jan 26 12:00:33 u034755 dhclient: bound to 10.16.13.92 -- renewal in 320632 seconds. Jan 26 12:00:33 u034755 ntpd[1362]: ntpd exiting on signal 15 Jan 26 12:00:33 u034755 ntpdate[1647]: adjust time server 10.16.15.1 offset 0.369700 sec Jan 26 12:00:33 u034755 ntpd[1675]: ntpd 4.2....@1.1549-o Fri Dec 4 18:08:42 UTC 2009 (1) Jan 26 12:00:33 u034755 ntpd[1676]: precision = 1.000 usec Jan 26 12:00:33 u034755 ntpd[1676]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled Jan 26 12:00:33 u034755 ntpd[1676]: Listening on interface #1 wildcard, ::#123 Disabled Jan 26 12:00:33 u034755 ntpd[1676]: Listening on interface #2 lo, ::1#123 Enabled Jan 26 12:00:33 u034755 ntpd[1676]: bind() fd 19, family 10, port 123, scope 2, addr fe80::21f:d0ff:fe82:422, in6_is_addr_multicast=0 flags=0x11 fails: Cannot assign requested address Jan 26 12:00:33 u034755 ntpd[1676]: unable to create socket on eth0 (3) for fe80::21f:d0ff:fe82:422#123 Jan 26 12:00:33 u034755 ntpd[1676]: failed to initialize interface for address fe80::21f:d0ff:fe82:422 Jan 26 12:00:33 u034755 ntpd[1676]: Listening on interface #4 lo, 127.0.0.1#123 Enabled Jan 26 12:00:33 u034755 ntpd[1676]: Listening on interface #5 eth0, 10.16.13.92#123 Enabled Jan 26 12:00:33 u034755 ntpd[1676]: kernel time sync status 2040 Jan 26 12:00:33 u034755 ntpd[1676]: frequency initialized -31.871 PPM from /var/lib/ntp/ntp.drift Jan 26 12:00:33 u034755 ntpd[1676]: Warning: the "dynamic" keyword has been obsoleted and will be removed in the next release Jan 26 12:01:00 u034755 NetworkManager: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Jan 26 12:01:00 u034755 NetworkManager: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Jan 26 12:01:19 u034755 kernel: [ 59.156097] CIFS VFS: Send error in SessSetup = -13 Jan 26 12:01:19 u034755 kernel: [ 59.156148] CIFS VFS: cifs_mount failed w/return code = -13 Jan 26 12:01:19 u034755 kernel: [ 59.158989] Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE Jan 26 12:01:19 u034755 kernel: [ 59.158995] CIFS VFS: Send error in SessSetup = -13 Jan 26 12:01:19 u034755 kernel: [ 59.159042] CIFS VFS: cifs_mount failed w/return code = -13 Jan 26 12:08:34 u034755 kernel: Kernel logging (proc) stopped. ======================================================================= syslog snippet 1: *no* eth0 lines on /etc/network/interfaces managed = false on /etc/NetworkManager/nm-system-settings.conf ============================================================== Jan 26 12:09:24 u034755 rsyslogd: [origin software="rsyslogd" swVersion="4.2.0" x-pid="877" x-info="http://www.rsyslog.com"] (re)start Jan 26 12:09:24 u034755 kernel: [ 0.000000] Linux version 2.6.31-17-generic (bui...@palmer) (gcc version 4.4.1 (Ubuntu 4.4.1-4ubuntu8) ) #54-Ubuntu SMP Thu Dec 10 16:20:31 UTC 2009 (Ubuntu 2.6.31-17.54-generic) Jan 26 12:09:24 u034755 NetworkManager: <info> starting... Jan 26 12:09:24 u034755 NetworkManager: <info> Trying to start the modem-manager... Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Nokia Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Sierra Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Ericsson MBM Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Generic Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Huawei Jan 26 12:09:24 u034755 modem-manager: Loaded plugin ZTE Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Option Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Gobi Jan 26 12:09:24 u034755 modem-manager: Loaded plugin MotoC Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Option High-Speed Jan 26 12:09:24 u034755 modem-manager: Loaded plugin Novatel Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: init! Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: update_system_hostname Jan 26 12:09:24 u034755 NetworkManager: SCPluginIfupdown: management mode: unmanaged Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: devices added (path: /sys/devices/pci0000:00/0000:00:1c.4/0000:04:00.0/net/eth0, iface: eth0) Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: device added (path: /sys/devices/pci0000:00/0000:00:1c.4/0000:04:00.0/net/eth0, iface: eth0): no ifupdown configuration found. Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/lo, iface: lo) Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found. Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: end _init. Jan 26 12:09:24 u034755 NetworkManager: Loaded plugin ifupdown: (C) 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list. Jan 26 12:09:24 u034755 NetworkManager: Loaded plugin keyfile: (c) 2007 - 2008 Red Hat, Inc. To report bugs please use the NetworkManager mailing list. Jan 26 12:09:24 u034755 NetworkManager: <info> Wireless now enabled by radio killswitch Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: (153344752) ... get_connections. Jan 26 12:09:24 u034755 NetworkManager: SCPlugin-Ifupdown: (153344752) ... get_connections (managed=false): return empty list. Jan 26 12:09:24 u034755 NetworkManager: Ifupdown: get unmanaged devices count: 0 Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): carrier is OFF Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): new Ethernet device (driver: 'r8169') Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/0 Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): now managed Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): device state change: 1 -> 2 (reason 2) Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): bringing up device. Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): preparing device. Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): deactivating device (reason: 2). Jan 26 12:09:24 u034755 NetworkManager: Added default wired connection 'Auto eth0' for /sys/devices/pci0000:00/0000:00:1c.4/0000:04:00.0/net/eth0 Jan 26 12:09:24 u034755 kernel: [ 11.837153] r8169: eth0: link up Jan 26 12:09:24 u034755 kernel: [ 11.837159] r8169: eth0: link up Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): carrier now ON (device state 2) Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): device state change: 2 -> 3 (reason 40) Jan 26 12:09:24 u034755 NetworkManager: <info> modem-manager is now available Jan 26 12:09:24 u034755 NetworkManager: <WARN> default_adapter_cb(): bluez error getting default adapter: The name org.bluez was not provided by any .service files Jan 26 12:09:24 u034755 NetworkManager: <info> Trying to start the supplicant ... Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) starting connection 'Auto eth0' Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): device state change: 3 -> 4 (reason 0) Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled... Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started... Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled... Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete. Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting... Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): device state change: 4 -> 5 (reason 0) Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful. Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled. Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete. Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started... Jan 26 12:09:24 u034755 NetworkManager: <info> (eth0): device state change: 5 -> 7 (reason 0) Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Beginning DHCP transaction (timeout in 45 seconds) Jan 26 12:09:24 u034755 dhclient: Internet Systems Consortium DHCP Client V3.1.2 Jan 26 12:09:24 u034755 dhclient: Copyright 2004-2008 Internet Systems Consortium. Jan 26 12:09:24 u034755 dhclient: All rights reserved. Jan 26 12:09:24 u034755 dhclient: For info, please visit http://www.isc.org/sw/dhcp/ Jan 26 12:09:24 u034755 dhclient: Jan 26 12:09:24 u034755 NetworkManager: <info> dhclient started with pid 983 Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP6 Configure Get) scheduled... Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete. Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP6 Configure Get) started... Jan 26 12:09:24 u034755 NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP6 Configure Get) complete. Jan 26 12:09:24 u034755 NetworkManager: <info> DHCP: device eth0 state changed (null) -> preinit Jan 26 12:09:24 u034755 dhclient: Listening on LPF/eth0/00:1f:d0:82:04:22 Jan 26 12:09:24 u034755 dhclient: Sending on LPF/eth0/00:1f:d0:82:04:22 Jan 26 12:09:24 u034755 dhclient: Sending on Socket/fallback Jan 26 12:09:25 u034755 nmbd[1292]: [2010/01/26 12:09:25, 0] nmbd/nmbd_subnetdb.c:206(create_subnets) Jan 26 12:09:25 u034755 nmbd[1292]: create_subnets: No local IPv4 non-loopback interfaces ! Jan 26 12:09:25 u034755 nmbd[1292]: [2010/01/26 12:09:25, 0] nmbd/nmbd_subnetdb.c:207(create_subnets) Jan 26 12:09:25 u034755 nmbd[1292]: create_subnets: Waiting for an interface to appear ... Jan 26 12:09:25 u034755 smbd[1294]: [2010/01/26 12:09:25, 0] printing/print_cups.c:103(cups_connect) Jan 26 12:09:25 u034755 smbd[1294]: Unable to connect to CUPS server localhost:631 - Connection refused Jan 26 12:09:25 u034755 smbd[1296]: [2010/01/26 12:09:25, 0] printing/print_cups.c:103(cups_connect) Jan 26 12:09:25 u034755 smbd[1296]: Unable to connect to CUPS server localhost:631 - Connection refused Jan 26 12:09:25 u034755 smbd[1297]: [2010/01/26 12:09:25, 0] libsmb/nmblib.c:834(send_udp) Jan 26 12:09:25 u034755 smbd[1297]: Packet send failed to 10.16.15.1(137) ERRNO=Network is unreachable Jan 26 12:09:25 u034755 smbd[1297]: [2010/01/26 12:09:25, 0] printing/nt_printing.c:627(nt_printing_init) Jan 26 12:09:25 u034755 smbd[1297]: nt_printing_init: error checking published printers: WERR_ACCESS_DENIED Jan 26 12:09:25 u034755 smbd[1297]: [2010/01/26 12:09:25, 0] smbd/server.c:456(smbd_open_one_socket) Jan 26 12:09:25 u034755 smbd[1297]: smbd_open_once_socket: open_socket_in: Address already in use Jan 26 12:09:25 u034755 smbd[1297]: [2010/01/26 12:09:25, 0] smbd/server.c:456(smbd_open_one_socket) Jan 26 12:09:25 u034755 smbd[1297]: smbd_open_once_socket: open_socket_in: Address already in use Jan 26 12:09:25 u034755 winbindd[1336]: [2010/01/26 12:09:25, 0] winbindd/winbindd_cache.c:2578(initialize_winbindd_cache) Jan 26 12:09:25 u034755 winbindd[1336]: initialize_winbindd_cache: clearing cache and re-creating with version number 1 Jan 26 12:09:25 u034755 ntpd[1358]: ntpd 4.2....@1.1549-o Fri Dec 4 18:08:42 UTC 2009 (1) Jan 26 12:09:25 u034755 ntpd[1359]: precision = 1.000 usec Jan 26 12:09:25 u034755 ntpd[1359]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled Jan 26 12:09:25 u034755 ntpd[1359]: Listening on interface #1 wildcard, ::#123 Disabled Jan 26 12:09:25 u034755 ntpd[1359]: Listening on interface #2 lo, ::1#123 Enabled Jan 26 12:09:25 u034755 ntpd[1359]: bind() fd 19, family 10, port 123, scope 2, addr fe80::21f:d0ff:fe82:422, in6_is_addr_multicast=0 flags=0x11 fails: Cannot assign requested address Jan 26 12:09:25 u034755 ntpd[1359]: unable to create socket on eth0 (3) for fe80::21f:d0ff:fe82:422#123 Jan 26 12:09:25 u034755 ntpd[1359]: failed to initialize interface for address fe80::21f:d0ff:fe82:422 Jan 26 12:09:25 u034755 ntpd[1359]: Listening on interface #4 lo, 127.0.0.1#123 Enabled Jan 26 12:09:25 u034755 ntpd[1359]: kernel time sync status 2040 Jan 26 12:09:25 u034755 ntpd[1359]: frequency initialized -31.871 PPM from /var/lib/ntp/ntp.drift Jan 26 12:09:25 u034755 ntpd[1359]: Warning: the "dynamic" keyword has been obsoleted and will be removed in the next release Jan 26 12:09:25 u034755 winbindd[1337]: [2010/01/26 12:09:25, 0] libsmb/nmblib.c:834(send_udp) Jan 26 12:09:25 u034755 winbindd[1337]: Packet send failed to 10.16.15.1(137) ERRNO=Network is unreachable Jan 26 12:09:26 u034755 ntpd[1359]: Listening on interface #5 eth0, fe80::21f:d0ff:fe82:422#123 Enabled Jan 26 12:09:28 u034755 dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 3 Jan 26 12:09:28 u034755 dhclient: DHCPOFFER of 10.16.13.92 from 10.16.13.100 Jan 26 12:09:28 u034755 dhclient: DHCPREQUEST of 10.16.13.92 on eth0 to 255.255.255.255 port 67 Jan 26 12:09:28 u034755 dhclient: DHCPACK of 10.16.13.92 from 10.16.13.100 Jan 26 12:09:28 u034755 NetworkManager: <info> DHCP: device eth0 state changed preinit -> bound Jan 26 12:09:28 u034755 NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure Get) scheduled... Jan 26 12:09:28 u034755 NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure Get) started... Jan 26 12:09:28 u034755 NetworkManager: <info> address 10.16.13.92 Jan 26 12:09:28 u034755 NetworkManager: <info> prefix 24 (255.255.255.0) Jan 26 12:09:28 u034755 NetworkManager: <info> gateway 10.16.13.100 Jan 26 12:09:28 u034755 NetworkManager: <info> nameserver '10.16.15.1' Jan 26 12:09:28 u034755 NetworkManager: <info> nameserver '212.142.144.66' Jan 26 12:09:28 u034755 NetworkManager: <info> nameserver '212.142.144.98' Jan 26 12:09:28 u034755 NetworkManager: <info> domain name 'H013085' Jan 26 12:09:28 u034755 NetworkManager: <info> wins '10.16.15.1' Jan 26 12:09:28 u034755 NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled... Jan 26 12:09:28 u034755 NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure Get) complete. Jan 26 12:09:28 u034755 NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) started... Jan 26 12:09:28 u034755 dhclient: bound to 10.16.13.92 -- renewal in 332505 seconds. Jan 26 12:09:29 u034755 NetworkManager: <info> (eth0): device state change: 7 -> 8 (reason 0) Jan 26 12:09:29 u034755 NetworkManager: <info> Policy set 'Auto eth0' (eth0) as default for routing and DNS. Jan 26 12:09:29 u034755 NetworkManager: <info> Activation (eth0) successful, device activated. Jan 26 12:09:29 u034755 NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete. Jan 26 12:09:29 u034755 ntpd[1359]: ntpd exiting on signal 15 Jan 26 12:09:29 u034755 ntpdate[1836]: adjust time server 10.16.15.1 offset 0.237228 sec Jan 26 12:09:29 u034755 ntpd[1866]: ntpd 4.2....@1.1549-o Fri Dec 4 18:08:42 UTC 2009 (1) Jan 26 12:09:29 u034755 ntpd[1867]: precision = 1.000 usec Jan 26 12:09:29 u034755 ntpd[1867]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled Jan 26 12:09:29 u034755 ntpd[1867]: Listening on interface #1 wildcard, ::#123 Disabled Jan 26 12:09:29 u034755 ntpd[1867]: Listening on interface #2 lo, ::1#123 Enabled Jan 26 12:09:29 u034755 ntpd[1867]: Listening on interface #3 eth0, fe80::21f:d0ff:fe82:422#123 Enabled Jan 26 12:09:29 u034755 ntpd[1867]: Listening on interface #4 lo, 127.0.0.1#123 Enabled Jan 26 12:09:29 u034755 ntpd[1867]: Listening on interface #5 eth0, 10.16.13.92#123 Enabled Jan 26 12:09:29 u034755 ntpd[1867]: kernel time sync status 2040 Jan 26 12:09:29 u034755 ntpd[1867]: frequency initialized -31.871 PPM from /var/lib/ntp/ntp.drift Jan 26 12:09:29 u034755 ntpd[1867]: Warning: the "dynamic" keyword has been obsoleted and will be removed in the next release Jan 26 12:10:28 u034755 kernel: [ 75.366493] Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE Jan 26 12:10:28 u034755 kernel: [ 75.366500] CIFS VFS: Send error in SessSetup = -13 Jan 26 12:10:28 u034755 kernel: [ 75.366548] CIFS VFS: cifs_mount failed w/return code = -13 Jan 26 12:10:28 u034755 kernel: [ 75.369347] Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE Jan 26 12:10:28 u034755 kernel: [ 75.369353] CIFS VFS: Send error in SessSetup = -13 Jan 26 12:10:28 u034755 kernel: [ 75.369399] CIFS VFS: cifs_mount failed w/return code = -13 Jan 26 12:11:08 u034755 NetworkManager: Ifupdown: get unmanaged devices count: 0 Jan 26 12:11:19 u034755 kernel: Kernel logging (proc) stopped. ============================================================================ Thierry Carrez(e)k dio: > I'm not surprised that user networking setup, as defined by NM/WICD, is > not available until the fully user logs in... so winbind won't work > until then, chicken and egg. > > I'm more surprised that winbind fails when systemwide networking is defined > though. > I suppose the syslog snippet you attached comes from a DHCP configuration > defined in /etc/networking/interfaces ? > If not, could you test that ? > Also could you try with static networking instead and let us know how that > goes ? > > ** Changed in: samba (Ubuntu) > Importance: Undecided => Medium > > ** Changed in: samba (Ubuntu) > Status: New => Incomplete > > ** Summary changed: > > - first login fails when NIC is managed by NM-wicd > + [winbind] first login fails when NIC is managed by NM-wicd > -- [winbind] first login fails when NIC is managed by NM-wicd https://bugs.launchpad.net/bugs/512777 You received this bug notification because you are a member of Ubuntu Server Team, which is subscribed to samba 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