[Date Prev][Date Next]
[Chronological]
[Thread]
[Top]
Mysterious ldap shutdown...
Hi,
I've got a problem... My openldap, install on a Debian Woody, is used
by different services (postfix, courier-{imap,pop...}, login,
etc). All Friday, from 4 weeks (in different hour), the ldap shutdown
cleanly without any visible explication. The last stop was the October
17 at 9h47 25sec AM (cf debug.log). But there is no cron running at
this time. The logs gave me no valuable reason and I can't see any bug
about that.
Does somebody could help me ?
Thanks & regards.
------------------------------
login@un_serveur$ uname -a
Linux un_serveur 2.4.18-ext3 #2 Fri Jul 12 13:54:23 CEST 2002 i686 unknown
login@un_serveur$ dpkg -l | grep ldap
ii ldap-utils 2.0.23-14 OpenLDAP utilities.
ii libldap2 2.0.23-14 OpenLDAP libraries (without TLS support).
ii libldap2-dev 2.0.23-14 OpenLDAP development libraries.
ii libldap2-tls 2.0.23-14 OpenLDAP libraries (with TLS support).
ii libnet-ldap-pe 0.29-1 A Client interface to LDAP servers
ii libnss-ldap 203-1 NSS module for using LDAP as a naming servic
ii libopenldap-ru 1.2.12.1-1 OpenLDAP runtime files for obsolete libopenl
ii libopenldap1 1.2.12.1-1 OpenLDAP libraries (obsoleted by libldap2).
ii libpam-ldap 156-1 Pluggable Authentication Module allowing LDA
rc openldapd 1.2.12-1 OpenLDAP server (slapd).
ii postfix-ldap 1.1.11.0-3 LDAP map support for Postfix
hi python-ldap 1.9.999.pre04- An LDAP module for Python.
login@un_serveur$ cat *.1.gz-log | grep "Oct 17 09:47:*"
debug.1.gz-log
Oct 17 09:47:25 un_serveur slapd[4108]: daemon: conn=97508 fd=70 connection from IP=127.0.0.1:48808 (IP=0.0.0.0:34049) accepted.
Oct 17 09:47:25 un_serveur slapd[4108]: deferring operation
Oct 17 09:47:25 un_serveur slapd[4108]: deferring operation Oct 17 09:47:25 un_serveur slapd[5294]: conn=17182 op=21 SRCH base="dc=RF" scope=2 filter="(uid=bj)"
Oct 17 09:47:25 un_serveur slapd[6936]: conn=7 op=3463 SRCH base="dc=RF" scope=2 filter="(&(objectClass=posixAccount)(uid=jmm))"
Oct 17 09:47:25 un_serveur slapd[6946]: conn=93 op=3508 SRCH base="dc=RF" scope=2 filter="(&(objectClass=posixAccount)(uid=jmm))"
Oct 17 09:47:25 un_serveur slapd[7301]: conn=97507 op=0 BIND dn="CN=ADMIN,DC=RF" method=128
Oct 17 09:47:25 un_serveur slapd[7301]: conn=97507 op=0 RESULT tag=97 err=0 text=
Oct 17 09:47:25 un_serveur slapd[7301]: conn=-1 fd=74 closed
--> Oct 17 09:47:25 un_serveur slapd[4108]: slapd shutdown: waiting for 4 threads to terminate
Oct 17 09:47:25 un_serveur slapd[6946]: conn=93 op=3508 SEARCH RESULT tag=101 err=0 text=
Oct 17 09:47:25 un_serveur slapd[6936]: conn=7 op=3463 SEARCH RESULT tag=101 err=0 text=
Oct 17 09:47:25 un_serveur slapd[5294]: conn=17182 op=21 SEARCH RESULT tag=101 err=0 text=
--> Oct 17 09:47:26 un_serveur slapd[4106]: slapd stopped.
----------------------
------------------------
kern.log.1.gz-log
----------------------
------------------------
log.nmbd.1.gz-log
----------------------
------------------------
log.smbd.1.gz-log
------------------------
log.winbindd.1.gz-log
----------------------
------------------------
lp-acct.1.gz-log
----------------------
------------------------
lp-errs.1.gz-log
----------------------
------------------------
lpr.log.1.gz-log
----------------------
------------------------
mail.err.1.gz-log
Oct 17 09:47:25 un_serveur postfix/smtpd[1649]: fatal: opening ldap:ldapsource Connection refused
Oct 17 09:47:29 un_serveur courierpop3login: LOGIN FAILED, ip=[::ffff:192.168.1.64]
----------------------
------------------------
mail.info.1.gz-log
Oct 17 09:47:25 un_serveur postfix/smtpd[1649]: warning: dict_ldap_connect: Unable to bind to server 192.168.1.52 as : 81 (Can't contact LDAP server)
Oct 17 09:47:25 un_serveur postfix/smtpd[1649]: fatal: opening ldap:ldapsource Connection refused
Oct 17 09:47:26 un_serveur postfix/local[1609]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=241, status=bounced (unknown user: "XX")
Oct 17 09:47:26 un_serveur postfix/local[1619]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=11, status=deferred (alias database unavailable)
Oct 17 09:47:26 un_serveur postfix/local[1608]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:26 un_serveur postfix/local[1615]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=331, status=bounced (unknown user: "XX")
Oct 17 09:47:26 un_serveur postfix/master[422]: warning: process /usr/lib/postfix/smtpd pid 1649 exit status 1
Oct 17 09:47:26 un_serveur postfix/master[422]: warning: /usr/lib/postfix/smtpd: bad command startup -- throttling
Oct 17 09:47:26 un_serveur postfix/local[1618]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=391, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur postfix/local[1613]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur postfix/local[1594]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=11, status=deferred (alias database unavailable)
Oct 17 09:47:27 un_serveur postfix/local[1616]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=331, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur postfix/local[1611]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur courierpop3login: Connection, ip=[::ffff:192.168.1.61]
Oct 17 09:47:27 un_serveur postfix/local[1617]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=421, status=bounced (unknown user: "XX")
Oct 17 09:47:28 un_serveur postfix/local[1612]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:28 un_serveur courierpop3login: Connection, ip=[::ffff:192.168.1.69]
Oct 17 09:47:28 un_serveur postfix/local[1614]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=361, status=bounced (unknown user: "XX")
Oct 17 09:47:29 un_serveur postfix/local[1610]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:29 un_serveur postfix/cleanup[1879]: 855B413E25: message-id=<XX@XX.com>
Oct 17 09:47:29 un_serveur courierpop3login: LOGIN FAILED, ip=[::ffff:192.168.1.64]
Oct 17 09:47:29 un_serveur postfix/local[1594]: warning: dict_ldap_connect: Unable to bind to server 192.168.1.52 as : 81 (Can't contact LDAP server)
Oct 17 09:47:29 un_serveur postfix/local[1594]: 855B413E25: to=<XX@XX.com>, relay=local, delay=0, status=deferred (alias database unavailable)
----------------------
------------------------
mail.log.1.gz-log
Oct 17 09:47:25 un_serveur postfix/smtpd[1649]: warning: dict_ldap_connect: Unable to bind to server 192.168.1.52 as : 81 (:Can't contact LDAP server)
Oct 17 09:47:25 un_serveur postfix/smtpd[1649]: fatal: opening ldap:ldapsource Connection refused
Oct 17 09:47:26 un_serveur postfix/local[1609]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=241, status=bounced (unknown user: "XX")
Oct 17 09:47:26 un_serveur postfix/local[1619]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=11, status=deferred (alias database unavailable)
Oct 17 09:47:26 un_serveur postfix/local[1608]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:26 un_serveur postfix/local[1615]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=331, status=bounced (unknown user: "XX")
Oct 17 09:47:26 un_serveur postfix/master[422]: warning: process /usr/lib/postfix/smtpd pid 1649 exit status 1
Oct 17 09:47:26 un_serveur postfix/master[422]: warning: /usr/lib/postfix/smtpd: bad command startup -- throttling
Oct 17 09:47:26 un_serveur postfix/local[1618]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=391, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur postfix/local[1613]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur postfix/local[1594]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=11, status=deferred (alias database unavailable)
Oct 17 09:47:27 un_serveur postfix/local[1616]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=331, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur postfix/local[1611]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:27 un_serveur courierpop3login: Connection, ip=[::ffff:192.168.1.61]
Oct 17 09:47:27 un_serveur postfix/local[1617]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=421, status=bounced (unknown user: "XX")
Oct 17 09:47:28 un_serveur postfix/local[1612]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:28 un_serveur courierpop3login: Connection, ip=[::ffff:192.168.1.69]
Oct 17 09:47:28 un_serveur postfix/local[1614]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=361, status=bounced (unknown user: "XX")
Oct 17 09:47:29 un_serveur postfix/local[1610]: 3F69413E5B: to=<XX@XX.com>, relay=local, delay=271, status=bounced (unknown user: "XX")
Oct 17 09:47:29 un_serveur postfix/cleanup[1879]: 855B413E25: message-id=<XX@XX.com>
Oct 17 09:47:29 un_serveur courierpop3login: LOGIN FAILED, ip=[::ffff:192.168.1.64]
Oct 17 09:47:29 un_serveur postfix/local[1594]: warning: dict_ldap_connect: Unable to bind to server 192.168.1.52 as : 81 (Can't contact LDAP server)
Oct 17 09:47:29 un_serveur postfix/local[1594]: 855B413E25: to=<XX@XX.com>, relay=local, delay=0, status=deferred (alias database unavailable)
----------------------
------------------------
------------------------
mail.warn.1.gz-log
Oct 17 09:47:25 un_serveur postfix/smtpd[1649]: warning: dict_ldap_connect: Unable to bind to server 192.168.1.52 as : 81 (Can't contact LDAP server)
Oct 17 09:47:25 un_serveur postfix/smtpd[1649]: fatal: opening ldap:ldapsource Connection refused
Oct 17 09:47:26 un_serveur postfix/master[422]: warning: process /usr/lib/postfix/smtpd pid 1649 exit status 1
Oct 17 09:47:26 un_serveur postfix/master[422]: warning: /usr/lib/postfix/smtpd: bad command startup -- throttling
Oct 17 09:47:29 un_serveur courierpop3login: LOGIN FAILED, ip=[::ffff:192.168.1.64]
Oct 17 09:47:29 un_serveur postfix/local[1594]: warning: dict_ldap_connect: Unable to bind to server 192.168.1.52 as : 81 (Can't contact LDAP server)
----------------------
------------------------
messages.1.gz-log
Oct 17 09:47:26 un_serveur authdaemond.plain: nss_ldap: reconnecting to LDAP server...
Oct 17 09:47:26 un_serveur authdaemond.plain: nss_ldap: reconnecting to LDAP server...
Oct 17 09:47:26 un_serveur authdaemond.plain: nss_ldap: reconnecting to LDAP server (sleeping 4 seconds)...
----------------------
------------------------
slapd.log.1.gz-log
Oct 17 09:47:25 un_serveur slapd[4108]: daemon: conn=97508 fd=70 connection from IP=127.0.0.1:48808 (IP=0.0.0.0:34049) accepted.
Oct 17 09:47:25 un_serveur slapd[4108]: deferring operation
Oct 17 09:47:25 un_serveur slapd[4108]: deferring operation
Oct 17 09:47:25 un_serveur slapd[5294]: conn=17182 op=21 SRCH base="dc=RF" scope=2 filter="(uid=bj)"
Oct 17 09:47:25 un_serveur slapd[6936]: conn=7 op=3463 SRCH base="dc=RF" scope=2 filter="(&(objectClass=posixAccount)(uid=jmm))"
Oct 17 09:47:25 un_serveur slapd[6946]: conn=93 op=3508 SRCH base="dc=RF" scope=2 filter="(&(objectClass=posixAccount)(uid=jmm))"
Oct 17 09:47:25 un_serveur slapd[7301]: conn=97507 op=0 BIND dn="CN=ADMIN,DC=RF" method=128
Oct 17 09:47:25 un_serveur slapd[7301]: conn=97507 op=0 RESULT tag=97 err=0 text=
Oct 17 09:47:25 un_serveur slapd[7301]: conn=-1 fd=74 closed
Oct 17 09:47:25 un_serveur slapd[4108]: slapd shutdown: waiting for 4 threads to terminate
Oct 17 09:47:25 un_serveur slapd[6946]: conn=93 op=3508 SEARCH RESULT tag=101 err=0 text=
Oct 17 09:47:25 un_serveur slapd[6936]: conn=7 op=3463 SEARCH RESULT tag=101 err=0 text=
Oct 17 09:47:25 un_serveur slapd[5294]: conn=17182 op=21 SEARCH RESULT tag=101 err=0 text=
Oct 17 09:47:26 un_serveur slapd[4106]: slapd stopped.
----------------------
------------------------
syslog.1.gz-log
----------------------
------------------------
user.log.1.gz-log
Oct 17 09:47:25 un_serveur authdaemond.plain: pam_ldap: ldap_simple_bind Can't contact LDAP server
Oct 17 09:47:25 un_serveur authdaemond.plain: pam_ldap: ldap_simple_bind Can't contact LDAP server
Oct 17 09:47:26 un_serveur authdaemond.plain: nss_ldap: reconnecting to LDAP server...
Oct 17 09:47:26 un_serveur authdaemond.plain: nss_ldap: reconnecting to LDAP server...
Oct 17 09:47:26 un_serveur authdaemond.plain: nss_ldap: reconnecting to LDAP server (sleeping 4 seconds)...
----------------------
--
Société Adelux -- http://www.adelux.fr
Sylvain de Tilly <sylvain.detilly@adelux.fr>
Ingénieur en sécurité des systèmes d'information
Tél. 01 46 88 60 55
Fax. 01 47 90 26 32