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

Bug#664976: debian-edu-config: installer hang during debian-edu-profile run at the end



Hi,

The timestamps in syslog are confusing.  Seems like they are
interchangeably UTC or localtime.

Anyway, assuming the log entries are the right order, it looks like
OpenLDAP got started before it was configured.

> Mar 21 22:03:10 in-target:  Main Tree Sched: shellcommands.secondpass pass 1 @ Wed Mar 21 23:03:09 2012

> Mar 21 22:03:10 in-target: Executing script /usr/sbin/snakeoil-on-ice...(timeout=5,uid=-1,gid=-1)
> Mar 21 22:03:10 in-target: (Setting umask to 77)
> Mar 21 22:03:10 in-target: cfengine:tjener:oil-on-ice: info: Running /usr/sbin/snakeoil-on-ice
> Mar 21 22:03:10 in-target: cfengine:tjener:oil-on-ice: cmp: /etc/skel/.mozilla/firef

OpenLDAP and BIND are started now:

> Mar 21 22:04:04 init: starting pid 375, tty '/dev/tty3': '-/bin/sh'
> Mar 21 23:04:05 slapd[22694]: @(#) $OpenLDAP: slapd 2.4.23 (Jun 16 2011 02:53:39) $ 	buildd@murphy:/build/buildd-openldap_2.4.23-7.2-i386-Y1mwvF/openldap-2.4.23/debian/build/servers/slapd
> Mar 21 23:04:10 slapd[22695]: slapd starting
> Mar 21 23:04:10 named[22708]: starting BIND 9.7.3 -4 -u bind

> Mar 21 23:04:11 named[22708]: running
> Mar 21 23:04:11 su[22717]: Successful su for bind by root
> Mar 21 23:04:11 su[22717]: + ??? root:bind
> Mar 21 23:04:11 su[22717]: pam_unix(su:session): session opened for user bind by (uid=0)
> Mar 21 23:04:11 su[22717]: pam_unix(su:session): session closed for user bind

> Mar 21 22:04:11 in-target: ox/debian-edu.default/cert_override.txt: Datei oder Verzeichnis nicht gefunden
> Mar 21 22:04:11 in-target: cfengine:tjener:oil-on-ice: info: /usr/sbin/snakeoil-on-ice: snakeoil-on-ice: -rw-r--r-- 1 root root 702 21. Mär 23:03 /opt/ltsp/i386/etc/iceweasel/profile/cert_override.txt
> Mar 21 22:04:11 in-target: cfengine:tjener: Finished script /usr/sbin/snakeoil-on-ice
> Mar 21 22:04:11 in-target: Performance(Exec(/usr/sbin/snakeoil-on-ice)): time=0.1491 secs, av=0.1491 +/- 0.0316


But only afterward is the SSL certificate generated for slapd:

> Mar 21 22:04:11 in-target:  Main Tree Sched: shellcommands.thirdpass pass 1 @ Wed Mar 21 23:03:11 2012

> Mar 21 22:04:11 in-target: Executing script /usr/bin/mkslapdcert...(timeout=0,uid=-1,gid=-1)

Here slapd may be already running, but not configured properly, so an
attempt to contact it might fail.  But then any attempt to start it,
would be ignored, because it's already running.

> Mar 21 22:04:11 in-target: cfengine:tjener:du-install: The LDAP server slapd seems not to be running. Trying to start slapd.
> Mar 21 22:04:11 in-target: cfengine:tjener:du-install: Starting OpenLDAP: slapd.
> Mar 21 22:04:11 in-target: cfengine:tjener:du-install: Starting domain name service...: bind9.
> Mar 21 22:04:11 in-target: cfengine:tjener:du-install: ldap_sasl_bind(SIMPLE): Can't contact LDAP server (-1)

So, firstly, why did slapd get started early?  (By snakeoil-on-ice?)

And secondly, maybe ldap-debian-edu-install should begin by trying to
stop slapd, just in case it's already running at that point.  Or
otherwise perform a 'restart' instead of 'start'.

Regards,
-- 
Steven Chamberlain
steven@pyro.eu.org



Reply to: