[Date Prev][Date Next] [Chronological] [Thread] [Top]

Bind to meta-backend returns err=52



OpenLDAP 2.3.20, FreeBSD 4.10-STABLE

A box that is hardly loaded will from time to time fail with:

Mar 30 06:16:17 bowler slapd[58817]: conn=21 fd=50 ACCEPT from IP=127.0.0.1:1792 (IP=0.0.0.0:389)
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 SRCH base="dc=CordoorsView" scope=2 deref=0 filter="(uid=bradp)"
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 SRCH attr=*
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[0]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[0]: (anonymous) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[1]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[1]: (anonymous) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[2]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[2]: (anonymous) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[3]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[3]: (anonymou s) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[4]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[4]: (anonymous) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[5]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[5]: (anonymous) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[6]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[6]: (anonymous) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_retry[7]: retrying URI="ldapi://%2Fvar%2Frun%2Fopenldap%2Fldapi" DN="".
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 meta_back_dobind[7]: (anonymous) err=52.
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=0 SEARCH RESULT tag=101 err=52 nentries=0 text=
Mar 30 06:16:17 bowler slapd[58817]: conn=21 op=1 UNBIND
Mar 30 06:16:17 bowler slapd[58817]: conn=21 fd=50 closed

Command was "ldapsearch -b dc=CordoorsView -h localhost (uid=bradp)".
Config file can be found at http://www.horsfall.org/slapd.conf .

Nothing significant in /var/log/messages.

Restarting SLAPD will fix it; it happened at an inopportune time, so I 
didn't have time to get a backtrace etc.

This looks similar to #4429, except it's in back-meta and not back-ldap.  
Could it be related?  A cursory look at bind-meta/bind.c shows it may be 
something to do with (line 549):

if ( mc->mc_refcnt == 1 ) {
	meta_clear_one_candidate( msc );
	LDAP_BACK_CONN_ISBOUND_CLEAR( msc );

	( void )rewrite_session_delete( mt->mt_rwmap.rwm_rw, op->o_conn );

	/* mc here must be the regular mc,
	 * reset and ready for init */
	rc = meta_back_init_one_conn( op, rs,
		mt, mc, candidate,
		LDAP_BACK_CONN_ISPRIV( mc ),
		LDAP_BACK_DONTSEND );

	} else {
		/* can't do anything about it */
		rc = LDAP_UNAVAILABLE;
	}

Anyone else seen this?

-- 
Dave Horsfall  DTM  VK2KFU  daveh@ci.com.au  Ph: +61 2 9552-5509 (d) -5500 (sw)
Corinthian Engrng P/L, Ste 54 Jones Bay Whf, 26-32 Pirrama Rd, Pyrmont 2009, AU