[Date Prev][Date Next] [Chronological] [Thread] [Top]
RE: tests stall in test 002 (ITS#51)

To: openldap-its@OpenLDAP.org
Subject: RE: tests stall in test 002 (ITS#51)
From: rhooper@cyberus.ca
Date: Thu, 21 Jan 1999 20:25:21 GMT
Sure... Here's the whole log, and yes, i meant --with-ldbm-api=gdbm, I typed
it in wrong (I should really learn to cut-and-paste now that I have X on the
same machine as email -- Yay 2 monitor Windows98).


slapd 1.1.3-Release (Thu Jan 21 14:14:11 EST 1999)
        root@db1.cyberus.ca:/usr/local/src/openldap-1.1.3/servers/slapd
slapd starting
do_bind
do_bind: version 2 dn () method 128
send_ldap_result 0::
do_search
using base "o=University of Michigan,c=US"
subtree_candidates: base: "o=University of Michigan,c=US" lookupbase
dn2entry_r: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (opened 0)
<= dn2id NOID
send_ldap_result 32::
do_unbind
do_bind
do_bind: version 2 dn () method 128
send_ldap_result 0::
do_search
using base "o=University of Michigan,c=US"
subtree_candidates: base: "o=University of Michigan,c=US" lookupbase
dn2entry_r: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
send_ldap_result 32::
do_unbind
do_bind
do_bind: version 2 dn () method 128
send_ldap_result 0::
do_search
using base "o=University of Michigan,c=US"
subtree_candidates: base: "o=University of Michigan,c=US" lookupbase
dn2entry_r: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
send_ldap_result 32::
do_unbind
do_bind
do_bind: version 2 dn () method 128
send_ldap_result 0::
do_search
using base "o=University of Michigan,c=US"
subtree_candidates: base: "o=University of Michigan,c=US" lookupbase
dn2entry_r: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
send_ldap_result 32::
do_unbind
do_bind
do_bind: version 2 dn () method 128
send_ldap_result 0::
do_search
using base "o=University of Michigan,c=US"
subtree_candidates: base: "o=University of Michigan,c=US" lookupbase
dn2entry_r: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
send_ldap_result 32::
do_unbind
do_bind
do_bind: version 2 dn () method 128
send_ldap_result 0::
do_search
using base "o=University of Michigan,c=US"
subtree_candidates: base: "o=University of Michigan,c=US" lookupbase
dn2entry_r: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
send_ldap_result 32::
do_unbind
do_bind
do_bind: version 2 dn (cn=Manager,o=University of Michigan,c=US) method 128
dn2entry_r: dn: "cn=Manager,o=University of Michigan,c=US"
=> dn2id( "cn=Manager,o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
dn2entry_r: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
send_ldap_result 0::
do_add
add_created_attrs
=> dn2id( "o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
next_id 4294967295: could not open "./test-db/NEXTID"
=> id2children_add( 0, 1 )
=> ldbm_cache_open( "./test-db/id2children.gdbm", 2, 600 )
<= ldbm_cache_open (opened 1)
<= id2children_add 0
=> index_add( 1, "o=University of Michigan, c=US" )
=> index_add_values( "dn", 1 )
=> ldbm_cache_open( "./test-db/dn.gdbm", 2, 600 )
<= ldbm_cache_open (opened 2)
*** index_add_values syntax 0x11 syntax bin 0x4
=> add_value( "*^O=" )
=> add_value( "*S" )
=> add_value( "*O=U" )
=> add_value( "*=UN" )
=> add_value( "*UNI" )
=> add_value( "*NIV" )
=> add_value( "*IVE" )
=> add_value( "*VER" )
=> add_value( "*ERS" )
=> add_value( "*RSI" )
=> add_value( "*SIT" )
=> add_value( "*ITY" )
=> add_value( "*TY " )
=> add_value( "*Y O" )
=> add_value( "* OF" )
=> add_value( "*OF " )
=> add_value( "*F M" )
=> add_value( "* MI" )
=> add_value( "*MIC" )
=> add_value( "*ICH" )
=> add_value( "*CHI" )
=> add_value( "*HIG" )
=> add_value( "*IGA" )
=> add_value( "*GAN" )
=> add_value( "*AN," )
=> add_value( "*N,C" )
=> add_value( "*,C=" )
=> add_value( "*C=U" )
=> add_value( "*=US" )
=> add_value( "*US" )
=> index_add_values( "objectclass", 1 )
=> ldbm_cache_open( "./test-db/objectclass.gdbm", 2, 600 )
<= ldbm_cache_open (opened 3)
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=TOP" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=ORGANIZATION" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=DOMAINRELATEDOBJECT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUOBJECT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUNONLEAFOBJECT" )
=> index_add_values( "l", 1 )
=> index_add_values( "st", 1 )
=> index_add_values( "streetaddress", 1 )
=> index_add_values( "o", 1 )
=> index_add_values( "description", 1 )
=> index_add_values( "postaladdress", 1 )
=> index_add_values( "telephonenumber", 1 )
=> index_add_values( "lastmodifiedtime", 1 )
=> index_add_values( "lastmodifiedby", 1 )
=> index_add_values( "associateddomain", 1 )
=> index_add_values( "creatorsname", 1 )
=> index_add_values( "createtimestamp", 1 )
<= index_add( 1, "o=University of Michigan, c=US" ) 0
=> dn2id_add( "o=University of Michigan,c=US", 1 )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id_add 0
=> id2entry_add( 1, "o=University of Michigan, c=US" )
=> ldbm_cache_open( "./test-db/id2entry.gdbm", 2, 600 )
<= ldbm_cache_open (opened 4)
====> cache_add_entry lock: entry o=University of Michigan, c=US id 1
already in dn cache
<= id2entry_add 0
send_ldap_result 0::
====> cache_return_entry_w
do_add
add_created_attrs
=> dn2id( "ou=People,o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
dn2entry_w: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
====> cache_find_entry_dn2id: found dn: O=UNIVERSITY OF MICHIGAN,C=US
<= dn2id 1 (in cache)
=> id2entry_w( 1 )
====> cache_find_entry_dn2id: found id: 1 rw: 1
<= id2entry_w 0x807c968 (cache)
=> id2children_add( 1, 2 )
=> ldbm_cache_open( "./test-db/id2children.gdbm", 2, 600 )
<= ldbm_cache_open (cache 1)
<= id2children_add 0
=> index_add( 2, "ou=People, o=University of Michigan, c=US" )
=> index_add_values( "dn", 2 )
=> ldbm_cache_open( "./test-db/dn.gdbm", 2, 600 )
<= ldbm_cache_open (cache 2)
*** index_add_values syntax 0x11 syntax bin 0x4
=> add_value( "*^OU" )
=> add_value( "*" )
=> add_value( "*OU=" )
=> add_value( "*U=P" )
=> add_value( "*=PE" )
=> add_value( "*PEO" )
=> add_value( "*EOP" )
=> add_value( "*OPL" )
=> add_value( "*PLE" )
=> add_value( "*LE," )
=> add_value( "*E,O" )
=> add_value( "*,O=" )
=> add_value( "*O=U" )
=> add_value( "*=UN" )
=> add_value( "*UNI" )
=> add_value( "*NIV" )
=> add_value( "*IVE" )
=> add_value( "*VER" )
=> add_value( "*ERS" )
=> add_value( "*RSI" )
=> add_value( "*SIT" )
=> add_value( "*ITY" )
=> add_value( "*TY " )
=> add_value( "*Y O" )
=> add_value( "* OF" )
=> add_value( "*OF " )
=> add_value( "*F M" )
=> add_value( "* MI" )
=> add_value( "*MIC" )
=> add_value( "*ICH" )
=> add_value( "*CHI" )
=> add_value( "*HIG" )
=> add_value( "*IGA" )
=> add_value( "*GAN" )
=> add_value( "*AN," )
=> add_value( "*N,C" )
=> add_value( "*,C=" )
=> add_value( "*C=U" )
=> add_value( "*=US" )
=> add_value( "*US" )
=> add_value( "*S" )
=> index_add_values( "objectclass", 2 )
=> ldbm_cache_open( "./test-db/objectclass.gdbm", 2, 600 )
<= ldbm_cache_open (cache 3)
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=TOP" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=ORGANIZATIONALUNIT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUOBJECT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUNONLEAFOBJECT" )
=> index_add_values( "ou", 2 )
=> index_add_values( "creatorsname", 2 )
=> index_add_values( "createtimestamp", 2 )
<= index_add( 2, "ou=People, o=University of Michigan, c=US" ) 0
=> dn2id_add( "ou=People,o=University of Michigan,c=US", 2 )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id_add 0
=> id2entry_add( 2, "ou=People, o=University of Michigan, c=US" )
=> ldbm_cache_open( "./test-db/id2entry.gdbm", 2, 600 )
<= ldbm_cache_open (cache 4)
====> cache_add_entry lock: entry ou=People, o=University of Michigan, c=US
id 2 already in dn cache
<= id2entry_add 0
send_ldap_result 0::
====> cache_return_entry_w
====> cache_return_entry_w
do_add
add_created_attrs
=> dn2id( "ou=Groups,o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
dn2entry_w: dn: "o=University of Michigan,c=US"
=> dn2id( "o=University of Michigan,c=US" )
====> cache_find_entry_dn2id: found dn: O=UNIVERSITY OF MICHIGAN,C=US
<= dn2id 1 (in cache)
=> id2entry_w( 1 )
====> cache_find_entry_dn2id: found id: 1 rw: 1
<= id2entry_w 0x807c968 (cache)
=> id2children_add( 1, 3 )
=> ldbm_cache_open( "./test-db/id2children.gdbm", 2, 600 )
<= ldbm_cache_open (cache 1)
<= id2children_add 0
=> index_add( 3, "ou=Groups, o=University of Michigan, c=US" )
=> index_add_values( "dn", 3 )
=> ldbm_cache_open( "./test-db/dn.gdbm", 2, 600 )
<= ldbm_cache_open (cache 2)
*** index_add_values syntax 0x11 syntax bin 0x4
=> add_value( "*^OU" )
=> add_value( "*" )
=> add_value( "*OU=" )
=> add_value( "*U=G" )
=> add_value( "*=GR" )
=> add_value( "*GRO" )
=> add_value( "*ROU" )
=> add_value( "*OUP" )
=> add_value( "*UPS" )
=> add_value( "*PS," )
=> add_value( "*S,O" )
=> add_value( "*,O=" )
=> add_value( "*O=U" )
=> add_value( "*=UN" )
=> add_value( "*UNI" )
=> add_value( "*NIV" )
=> add_value( "*IVE" )
=> add_value( "*VER" )
=> add_value( "*ERS" )
=> add_value( "*RSI" )
=> add_value( "*SIT" )
=> add_value( "*ITY" )
=> add_value( "*TY " )
=> add_value( "*Y O" )
=> add_value( "* OF" )
=> add_value( "*OF " )
=> add_value( "*F M" )
=> add_value( "* MI" )
=> add_value( "*MIC" )
=> add_value( "*ICH" )
=> add_value( "*CHI" )
=> add_value( "*HIG" )
=> add_value( "*IGA" )
=> add_value( "*GAN" )
=> add_value( "*AN," )
=> add_value( "*N,C" )
=> add_value( "*,C=" )
=> add_value( "*C=U" )
=> add_value( "*=US" )
=> add_value( "*US" )
=> add_value( "*S" )
=> index_add_values( "objectclass", 3 )
=> ldbm_cache_open( "./test-db/objectclass.gdbm", 2, 600 )
<= ldbm_cache_open (cache 3)
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=TOP" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=ORGANIZATIONALUNIT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUOBJECT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUNONLEAFOBJECT" )
=> index_add_values( "ou", 3 )
=> index_add_values( "lastmodifiedtime", 3 )
=> index_add_values( "lastmodifiedby", 3 )
=> index_add_values( "creatorsname", 3 )
=> index_add_values( "createtimestamp", 3 )
<= index_add( 3, "ou=Groups, o=University of Michigan, c=US" ) 0
=> dn2id_add( "ou=Groups,o=University of Michigan,c=US", 3 )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id_add 0
=> id2entry_add( 3, "ou=Groups, o=University of Michigan, c=US" )
=> ldbm_cache_open( "./test-db/id2entry.gdbm", 2, 600 )
<= ldbm_cache_open (cache 4)
====> cache_add_entry lock: entry ou=Groups, o=University of Michigan, c=US
id 3 already in dn cache
<= id2entry_add 0
send_ldap_result 0::
do_add
add_created_attrs
=> dn2id( "ou=Alumni Association,ou=People,o=University of Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
dn2entry_w: dn: "ou=People,o=University of Michigan,c=US"
=> dn2id( "ou=People,o=University of Michigan,c=US" )
====> cache_find_entry_dn2id: found dn: OU=PEOPLE,O=UNIVERSITY OF
MICHIGAN,C=US
<= dn2id 2 (in cache)
=> id2entry_w( 2 )
====> cache_find_entry_dn2id: found id: 2 rw: 1
<= id2entry_w 0x807fd38 (cache)
=> id2children_add( 2, 4 )
=> ldbm_cache_open( "./test-db/id2children.gdbm", 2, 600 )
<= ldbm_cache_open (cache 1)
====> cache_return_entry_w
====> cache_return_entry_w
<= id2children_add 0
=> index_add( 4, "ou=Alumni Association, ou=People, o=University of
Michigan, c=US" )
=> index_add_values( "dn", 4 )
=> ldbm_cache_open( "./test-db/dn.gdbm", 2, 600 )
<= ldbm_cache_open (cache 2)
*** index_add_values syntax 0x11 syntax bin 0x4
=> add_value( "*^OU" )
=> add_value( "*US$" )
=> add_value( "*OU=" )
=> add_value( "*U=A" )
=> add_value( "*=AL" )
=> add_value( "*ALU" )
=> add_value( "*LUM" )
=> add_value( "*UMN" )
=> add_value( "*MNI" )
=> add_value( "*NI " )
=> add_value( "*I A" )
=> add_value( "* AS" )
=> add_value( "*ASS" )
=> add_value( "*SSO" )
=> add_value( "*SOC" )
=> add_value( "*OCI" )
=> add_value( "*CIA" )
=> add_value( "*IAT" )
=> add_value( "*ATI" )
=> add_value( "*TIO" )
=> add_value( "*ION" )
=> add_value( "*ON," )
=> add_value( "*N,O" )
=> add_value( "*,OU" )
=> add_value( "*OU=" )
=> add_value( "*U=P" )
=> add_value( "*=PE" )
=> add_value( "*PEO" )
=> add_value( "*EOP" )
=> add_value( "*OPL" )
=> add_value( "*PLE" )
=> add_value( "*LE," )
=> add_value( "*E,O" )
=> add_value( "*,O=" )
=> add_value( "*O=U" )
=> add_value( "*=UN" )
=> add_value( "*UNI" )
=> add_value( "*NIV" )
=> add_value( "*IVE" )
=> add_value( "*VER" )
=> add_value( "*ERS" )
=> add_value( "*RSI" )
=> add_value( "*SIT" )
=> add_value( "*ITY" )
=> add_value( "*TY " )
=> add_value( "*Y O" )
=> add_value( "* OF" )
=> add_value( "*OF " )
=> add_value( "*F M" )
=> add_value( "* MI" )
=> add_value( "*MIC" )
=> add_value( "*ICH" )
=> add_value( "*CHI" )
=> add_value( "*HIG" )
=> add_value( "*IGA" )
=> add_value( "*GAN" )
=> add_value( "*AN," )
=> add_value( "*N,C" )
=> add_value( "*,C=" )
=> add_value( "*C=U" )
=> add_value( "*=US" )
=> add_value( "*US" )
=> add_value( "*S" )
=> add_value( "*" )
=> index_add_values( "objectclass", 4 )
=> ldbm_cache_open( "./test-db/objectclass.gdbm", 2, 600 )
<= ldbm_cache_open (cache 3)
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=TOP" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=ORGANIZATIONALUNIT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUOBJECT" )
=> add_value( "?*" )
*** index_add_values syntax 0x1 syntax bin 0x4
=> add_value( "=QUIPUNONLEAFOBJECT" )
=> index_add_values( "ou", 4 )
=> index_add_values( "creatorsname", 4 )
=> index_add_values( "createtimestamp", 4 )
<= index_add( 4, "ou=Alumni Association, ou=People, o=University of
Michigan, c=US" ) 0
=> dn2id_add( "ou=Alumni Association,ou=People,o=University of
Michigan,c=US", 4 )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id_add 0
=> id2entry_add( 4, "ou=Alumni Association, ou=People, o=University of
Michigan, c=US" )
=> ldbm_cache_open( "./test-db/id2entry.gdbm", 2, 600 )
<= ldbm_cache_open (cache 4)
====> cache_add_entry lock: entry ou=Alumni Association, ou=People,
o=University of Michigan, c=US id 4 already in dn cache
<= id2entry_add 0
send_ldap_result 0::
do_add
add_created_attrs
=> dn2id( "ou=Information Technology Division,ou=People,o=University of
Michigan,c=US" )
=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
dn2entry_w: dn: "ou=People,o=University of Michigan,c=US"
=> dn2id( "ou=People,o=University of Michigan,c=US" )
====> cache_find_entry_dn2id: found dn: OU=PEOPLE,O=UNIVERSITY OF
MICHIGAN,C=US
slapd got shutdown signal 2
slapd got do_nothing signal 16
slapd shutting down - waiting for 2 threads to terminate


--
Roy Hooper
Sr. Systems Administrator
Cyberus Online Inc.
(613) 233-0068


> -----Original Message-----
> From: owner-openldap-bugs@OpenLDAP.org
> [mailto:owner-openldap-bugs@OpenLDAP.org]On Behalf Of Kurt@OpenLDAP.org
> Sent: Thursday, January 21, 1999 3:11 PM
> To: openldap-its@OpenLDAP.org
> Subject: Re: tests stall in test 002 (ITS#51)
>
>
> At 07:31 PM 1/21/99 GMT, rhooper@cyberus.ca wrote:
> >in the 'tests' directory, the 'make' process stalls at:
> >
> >>>>>> Starting test002-populate ...
> >Cleaning up in ./test-db...
> >Starting slapd on TCP/IP port 9009...
> >Using ldapsearch to check that slapd is running...
> >Using ldapmodify to populate the database...
> >
> >root@db1:tests# tail test-db/master.log
> >=> dn2id( "ou=Information Technology Division,ou=People,o=University of
> >Michigan,c=US" )
> >=> ldbm_cache_open( "./test-db/dn2id.gdbm", 2, 600 )
> ><= ldbm_cache_open (cache 0)
> ><= dn2id NOID
> >dn2entry_w: dn: "ou=People,o=University of Michigan,c=US"
> >=> dn2id( "ou=People,o=University of Michigan,c=US" )
> >====> cache_find_entry_dn2id: found dn: OU=PEOPLE,O=UNIVERSITY
> OF MICHIGAN,C=US
>
> Looks like it deadlocked here.
>
> Can you provide the log entries from the start of this operation?
> (up to the preceeding do_search, do_modify, do_delete, do_bind,
> or send_ldap_result)
>
> >LIBS="-lpthread -lposix4"; export LIBS
> >./configure --enable-shared --with-threads --with-ldbm-backend=gdbm
> >AND
> >./configure --enable-shared --with-threads
>
> As --with-ldbm-backend is not a valid option (assume you meant
> --with-ldbm-api).
>
> Kurt
>
>
Prev by Date: Re: tests stall in test 002 (ITS#51)
Next by Date: Possible memory leak in libldap.a/liblber.a
Index(es):
- Chronological
- Thread