[Date Prev][Date Next] [Chronological] [Thread] [Top]
Re: Slapd sometimes crashes after starting the same search action three times

To: "default default" <gerritvandenhul@lycos.nl>
Subject: Re: Slapd sometimes crashes after starting the same search action three times
From: "Pierangelo Masarati" <ando@sys-net.it>
Date: Tue, 5 Apr 2005 21:41:55 +0200 (CEST)
Cc: openldap-software@OpenLDAP.org
Importance: Normal
In-reply-to: <0DDD57EA68D850F71131D173@cadabra-dsl.stanford.edu>
References: <1112718205012808@lycos-europe.com> <0DDD57EA68D850F71131D173@cadabra-dsl.stanford.edu>
User-agent: SquirrelMail/1.4.3a-1
Also, I suggest you try to reproduce the problem using a non-stripped
slapd, so that the presence of debug symbols can help in getting
information about the reason of the crash.

p.

>
>
> --On Tuesday, April 05, 2005 4:23 PM +0000 default default
> <gerritvandenhul@lycos.nl> wrote:
>
>>
>> Hi all!
>
> Since you can reproduce this with OpenLDAP 2.2.24, it likely should be
> filed as an ITS at:
>
> <http://www.openldap.org/its/>
>
> --Quanah
>
>
>> I have a problem with RedHat 4.0 and openldap 2.2.13.
>>
>> Slapd sometimes crashes after starting the same search action three
>> times, at the same time.
>> Slapd is started just before these search actions.
>>
>> When I remove the regex line from the access control list, I can't
>> reproduce the error.
>> I can't reproduce the error on a single processor system either (one
>> XEON
>> processor; hypertreading disabled).
>>
>> I have reproduced the error also with RedHat 3.0 and with openldap
>> 2.2.24.
>>
>> Perhaps this is a problem with acl parsing on a multi-processor system?
>>
>> Greetings,
>>
>> Gerrit van den Hul
>>
>>
>> System: HP Proliant with two XEON processsors (four processors for O.S.)
>> O.S.: RedHat 4.0 ES
>>
>> (Stripped) openldap configuration:
>>
>> loglevel           5
>> sizelimit           50000
>> timelimit           3600
>> sockbuf_max_incoming_auth      8000000
>> idletimeout         0
>> schemacheck         on
>> defaultsearchbase   "o=org,c=nl"
>> allow               bind_v2
>>
>> database      bdb
>> checkpoint    250 15
>> suffix        "o=org,c=NL"
>> directory     /usr/local/openldap/openldapDB
>> index          objectClass      eq
>> index          cn               eq,sub
>>
>> access to dn.regex="orgcode=(.*),ou=lb,o=org,c=nl" attr="data"
>>         by dn.regex="cn=updater,orgcode=$1,ou=lb,o=org,c=nl" write
>>
>> access to *
>>         by self write
>>         by * read
>>
>>
>> DB configuration:
>>
>> set_cachesize   0       500000000       0
>>
>>
>> Logfile:
>>
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_db_open:
>> dbenv_open(/usr/local/openldap/openldapDB)
>> Apr  5 13:27:18 localhost slapd[3038]: slapd starting
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(10)
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(10): got connid=0
>> Apr  5 13:27:18 localhost slapd[3038]: connection_read(10): checking for
>> input on id=0
>> Apr  5 13:27:18 localhost slapd[3038]: ber_get_next on fd 10 failed
>> errno=11 (Resource temporarily unavailable)
>> Apr  5 13:27:18 localhost slapd[3038]: do_bind
>> Apr  5 13:27:18 localhost slapd[3038]: >>> dnPrettyNormal: <>
>> Apr  5 13:27:18 localhost slapd[3038]: <<< dnPrettyNormal: <>, <>
>> Apr  5 13:27:18 localhost slapd[3038]: do_bind: version=2 dn=""
>> method=128
>> Apr  5 13:27:18 localhost slapd[3038]: send_ldap_result: conn=0 op=0 p=2
>> Apr  5 13:27:18 localhost slapd[3038]: send_ldap_result: err=0
>> matched=""
>> text=""
>> Apr  5 13:27:18 localhost slapd[3038]: send_ldap_response: msgid=1
>> tag=97
>> err=0
>> Apr  5 13:27:18 localhost slapd[3038]: do_bind: v2 anonymous bind
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(11)
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(11): got connid=1
>> Apr  5 13:27:18 localhost slapd[3038]: connection_read(11): checking for
>> input on id=1
>> Apr  5 13:27:18 localhost slapd[3038]: ber_get_next on fd 11 failed
>> errno=11 (Resource temporarily unavailable)
>> Apr  5 13:27:18 localhost slapd[3038]: do_bind
>> Apr  5 13:27:18 localhost slapd[3038]: >>> dnPrettyNormal: <>
>> Apr  5 13:27:18 localhost slapd[3038]: <<< dnPrettyNormal: <>, <>
>> Apr  5 13:27:18 localhost slapd[3038]: do_bind: version=2 dn=""
>> method=128
>> Apr  5 13:27:18 localhost slapd[3038]: send_ldap_result: conn=1 op=0 p=2
>> Apr  5 13:27:18 localhost slapd[3038]: send_ldap_result: err=0
>> matched=""
>> text=""
>> Apr  5 13:27:18 localhost slapd[3038]: send_ldap_response: msgid=1
>> tag=97
>> err=0
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(10)
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(10): got connid=0
>> Apr  5 13:27:18 localhost slapd[3038]: connection_read(10): checking for
>> input on id=0
>> Apr  5 13:27:18 localhost slapd[3038]: do_bind: v2 anonymous bind
>> Apr  5 13:27:18 localhost slapd[3038]: ber_get_next on fd 10 failed
>> errno=11 (Resource temporarily unavailable)
>> Apr  5 13:27:18 localhost slapd[3038]: do_search
>> Apr  5 13:27:18 localhost slapd[3038]: >>> dnPrettyNormal:
>> <ou=LB,o=org,c=NL>
>> Apr  5 13:27:18 localhost slapd[3038]: <<< dnPrettyNormal:
>> <ou=LB,o=org,c=NL>, <ou=lb,o=org,c=nl>
>> Apr  5 13:27:18 localhost slapd[3038]: SRCH "ou=LB,o=org,c=NL" 1 0
>> Apr  5 13:27:18 localhost slapd[3038]:     0 1000 0
>> Apr  5 13:27:18 localhost slapd[3038]:     filter:
>> (&(&(activeEntry=0)(objectClass=organizationalUnit)(orgCode=1488))(!(modi
>> fyTimestamp<=20050225064438Z)))
>> Apr  5 13:27:18 localhost slapd[3038]:     attrs:
>> Apr  5 13:27:18 localhost slapd[3038]:  orgID
>> Apr  5 13:27:18 localhost slapd[3038]:
>> Apr  5 13:27:18 localhost slapd[3038]: ==> limits_get: conn=0 op=1
>> dn="[anonymous]"
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_search
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_dn2entry("ou=lb,o=org,c=nl")
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_dn2id( "o=org,c=nl" )
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_dn2id: got id=0x00000001
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_dn2id( "ou=lb,o=org,c=nl"
>> )
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_dn2id: got id=0x00000002
>> Apr  5 13:27:18 localhost slapd[3038]: entry_decode: "ou=LB,o=org,c=NL"
>> Apr  5 13:27:18 localhost slapd[3038]: <= entry_decode(ou=LB,o=org,c=NL)
>> Apr  5 13:27:18 localhost slapd[3038]: search_candidates:
>> base="ou=lb,o=org,c=nl" (0x00000002) scope=1
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_dn2idl( "ou=lb,o=org,c=nl"
>> )
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key:
>> %ou=lb,o=org,c=nl
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_dn2idl: id=369 first=3
>> last=245732
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (objectClass)
>> Apr  5 13:27:18 localhost slapd[3038]: => key_read
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key: [b49d1940]
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_index_read: failed
>> (-30990)
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates: id=0,
>> first=0, last=0
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (activeEntry)
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates:
>> (activeEntry) index_param failed (18)
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (objectClass)
>> Apr  5 13:27:18 localhost slapd[3038]: => key_read
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key: [9bee355f]
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_index_read 1278 candidates
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates:
>> id=1278, first=2, last=286888
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (orgCode)
>> Apr  5 13:27:18 localhost slapd[3038]: => key_read
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key: [e9046241]
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(11)
>> Apr  5 13:27:18 localhost slapd[3038]: connection_get(11): got connid=1
>> Apr  5 13:27:18 localhost slapd[3038]: connection_read(11): checking for
>> input on id=1
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_index_read 1 candidates
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates: id=1,
>> first=635, last=635
>> Apr  5 13:27:18 localhost slapd[3038]: do_search
>> Apr  5 13:27:18 localhost slapd[3038]: >>> dnPrettyNormal:
>> <ou=LB,o=org,c=NL>
>> Apr  5 13:27:18 localhost slapd[3038]: <<< dnPrettyNormal:
>> <ou=LB,o=org,c=NL>, <ou=lb,o=org,c=nl>
>> Apr  5 13:27:18 localhost slapd[3038]: SRCH "ou=LB,o=org,c=NL" 1 0
>> Apr  5 13:27:18 localhost slapd[3038]:     0 1000 0
>> Apr  5 13:27:18 localhost slapd[3038]: ber_get_next on fd 11 failed
>> errno=11 (Resource temporarily unavailable)
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_search_candidates: id=1
>> first=635 last=635
>> Apr  5 13:27:18 localhost slapd[3038]:     filter:
>> (&(&(activeEntry=0)(objectClass=organizationalUnit)(orgCode=1488))(!(modi
>> fyTimestamp<=20050225064438Z)))
>> Apr  5 13:27:18 localhost slapd[3038]:     attrs:
>> Apr  5 13:27:18 localhost slapd[3038]:  orgID
>> Apr  5 13:27:18 localhost slapd[3038]:
>> Apr  5 13:27:18 localhost slapd[3038]: ==> limits_get: conn=1 op=1
>> dn="[anonymous]"
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_search
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_dn2entry("ou=lb,o=org,c=nl")
>> Apr  5 13:27:18 localhost slapd[3038]: search_candidates:
>> base="ou=lb,o=org,c=nl" (0x00000002) scope=1
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_dn2idl( "ou=lb,o=org,c=nl"
>> )
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key:
>> %ou=lb,o=org,c=nl
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_dn2idl: id=369 first=3
>> last=245732
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (objectClass)
>> Apr  5 13:27:18 localhost slapd[3038]: => key_read
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key: [b49d1940]
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_index_read: failed
>> (-30990)
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates: id=0,
>> first=0, last=0
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (activeEntry)
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates:
>> (activeEntry) index_param failed (18)
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (objectClass)
>> Apr  5 13:27:18 localhost slapd[3038]: => key_read
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key: [9bee355f]
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_index_read 1278 candidates
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates:
>> id=1278, first=2, last=286888
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_equality_candidates
>> (orgCode)
>> Apr  5 13:27:18 localhost slapd[3038]: => key_read
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_idl_fetch_key: [e9046241]
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_index_read 1 candidates
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_equality_candidates: id=1,
>> first=635, last=635
>> Apr  5 13:27:18 localhost slapd[3038]: bdb_search_candidates: id=1
>> first=635 last=635
>> Apr  5 13:27:18 localhost slapd[3038]: entry_decode:
>> "orgCode=1488,ou=LB,o=org,c=NL"
>> Apr  5 13:27:18 localhost slapd[3038]: entry_decode:
>> "orgCode=1488,ou=LB,o=org,c=NL"
>> Apr  5 13:27:18 localhost slapd[3038]: <=
>> entry_decode(orgCode=1488,ou=LB,o=org,c=NL)
>> Apr  5 13:27:18 localhost slapd[3038]: <=
>> entry_decode(orgCode=1488,ou=LB,o=org,c=NL)
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_dn2id(
>> "orgCode=1488,ou=lb,o=org,c=nl" )
>> Apr  5 13:27:18 localhost slapd[3038]: => bdb_dn2id(
>> "orgCode=1488,ou=lb,o=org,c=nl" )
>> Apr  5 13:27:18 localhost slapd[3038]: <= bdb_dn2id: got id=0x0000027b
>>
>>
>> Stack trace:
>>
>># 0  0x007a719e in build_trtable () from /lib/tls/libc.so.6
>># 1  0x007ae234 in re_search_internal () from /lib/tls/libc.so.6
>># 2  0x007af912 in regexec@@GLIBC_2.3.4 () from /lib/tls/libc.so.6
>># 3  0x00aa3d19 in access_allowed () from /usr/sbin/slapd
>># 4  0x00aa16f2 in do_abandon () from /usr/sbin/slapd
>># 5  0x00aa1f67 in test_filter () from /usr/sbin/slapd
>># 6  0x00aa1c78 in test_filter () from /usr/sbin/slapd
>># 7  0x00aa1c78 in test_filter () from /usr/sbin/slapd
>># 8  0x00addc0f in bdb_do_search () from /usr/sbin/slapd
>># 9  0x097d9b28 in ?? ()
>># 10 0x921fe2b4 in ?? ()
>># 11 0x9263de50 in ?? ()
>># 12 0x00000001 in ?? ()
>># 13 0x00000024 in ?? ()
>># 14 0x9263df10 in ?? ()
>># 15 0x00000000 in ?? ()
>>
>>
>> Gratis je email via Outlook lezen? Download nu Lycos Inside van Lycos
>> Mail!
>
>
>
> --
> Quanah Gibson-Mount
> Principal Software Developer
> ITSS/Shared Services
> Stanford University
> GnuPG Public Key: http://www.stanford.edu/~quanah/pgp.html
>
> "These censorship operations against schools and libraries are stronger
> than ever in the present religio-political climate. They often focus on
> fantasy and sf books, which foster that deadly enemy to bigotry and blind
> faith, the imagination." -- Ursula K. Le Guin
>
>


-- 
Pierangelo Masarati
mailto:pierangelo.masarati@sys-net.it


    SysNet - via Dossi,8 27100 Pavia Tel: +390382573859 Fax: +390382476497
References:
- Slapd sometimes crashes after starting the same search action three times
  - From: "default default" <gerritvandenhul@lycos.nl>
- Re: Slapd sometimes crashes after starting the same search action three times
  - From: Quanah Gibson-Mount <quanah@stanford.edu>
Prev by Date: Re: structure
Next by Date: Re: Setting up a Proxy Cache
Index(es):
- Chronological
- Thread