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

Re: deferring operation ?



This is your problem:
Jul  4 13:50:03 annuaire slapd[19523]: connection_read(18): no connection!

That is why it is deferring the operation.  A quick google on that
shows some tuning of idle timeouts and possibly ulimit might be
helpful.  I would recommend that you start tracking connections and
file descriptors to get a feel of conditions surrounding your
"freeze".

_Matt


On 7/4/05, Roderick Petetin <Roderick.Petetin@insa-rennes.fr> wrote:
> Hi,
> 
> I'm facing a problem with my openldap server.
> It freezes sometimes (and no longer respond to other requests) with this
> message on the log file :
> *Jul  4 13:50:03 annuaire slapd[19523]: connection_input: conn=7554
> deferring operation: binding
> *
> I couldn't find anything on the archives about this problem. I tried to
> reindex the database, open acl search for anonymous and turn off all
> logs but it doesn't completely solve my problem (the freezes happens
> less times a day but my server still doesn't talk back sometimes)*.
> 
> *Here is my config : (Bi-pro Xeon - 2 Gb RAM) RedHat EL AS 3.0 -
> openldap 2.2.13 - BDB 4.2.52 and ldap is used by mail and SSO (postfix -
> cyrus-imapd -saslauthd and Yale-CAS)
> 
> Here is the full log message for a request :
> *Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 fd=12 ACCEPT from
> IP=10.5.1.4:35305 (IP=0.0.0.0:389)
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7552 fd=18 closed
> Jul  4 13:50:03 annuaire slapd[19523]: connection_read(18): no connection!
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7553 op=3 BIND anonymous
> mech=implicit ssf=0
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=0 BIND dn="" method=128
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7553 op=3 BIND dn="" method=128
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=0 RESULT tag=97
> err=0 text=
> Jul  4 13:50:03 annuaire slapd[19523]: connection_input: conn=7554
> deferring operation: binding
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7553 op=3 RESULT tag=97
> err=0 text=
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=1 SRCH
> base="dc=insa-rennes,dc=fr" scope=2 deref=0 filter="(uid=mguichao)"
> Jul  4 13:50:03 annuaire slapd[19523]: connection_input: conn=7553
> deferring operation: binding
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=1 SEARCH RESULT
> tag=101 err=0 nentries=1 text=
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7553 op=4 UNBIND
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7555 fd=18 ACCEPT from
> IP=10.5.1.4:35306 (IP=0.0.0.0:389)
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7553 fd=19 closed
> Jul  4 13:50:03 annuaire slapd[19523]: connection_read(19): no connection!
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=2 BIND
> dn="uid=mguichao,ou=people,dc=insa-rennes,dc=fr" method=128
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=2 BIND
> dn="uid=mguichao,ou=people,dc=insa-rennes,dc=fr" mech=SIMPLE ssf=0
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=2 RESULT tag=97
> err=0 text=
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7555 op=0 BIND dn="" method=128
> Jul  4 13:50:03 annuaire slapd[19523]: connection_input: conn=7554
> deferring operation: binding
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7555 op=0 RESULT tag=97
> err=0 text=
> Jul  4 13:50:03 annuaire slapd[19523]: connection_input: conn=7555
> deferring operation: binding
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=3 BIND anonymous
> mech=implicit ssf=0
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7556 fd=19 ACCEPT from
> IP=10.5.1.4:35292 (IP=0.0.0.0:389)
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7555 op=1 SRCH
> base="dc=insa-rennes,dc=fr" scope=2 deref=0 filter="(uid=ejoncour)"
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=3 BIND dn="" method=128
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7555 op=1 SEARCH RESULT
> tag=101 err=0 nentries=1 text=
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7555 op=2 BIND
> dn="uid=ejoncour,ou=people,dc=insa-rennes,dc=fr" method=128
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=3 RESULT tag=97
> err=0 text=
> Jul  4 13:50:03 annuaire slapd[19523]: connection_input: conn=7554
> deferring operation: binding
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7555 op=2 RESULT tag=97
> err=49 text=
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 op=4 UNBIND
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7557 fd=21 ACCEPT from
> IP=10.5.1.4:35307 (IP=0.0.0.0:389)
> Jul  4 13:50:03 annuaire slapd[19523]: conn=7554 fd=12 closed*
>