[Date Prev][Date Next]
[Chronological]
[Thread]
[Top]
OpenLDAP and PROFTPD
I am trying to link Proftpd with Openldap. I have created a user
on openldap "posixtest2". I cannot login to proftpd with this user
although proftpd is making a connection and searching for user info
on openldap. I do not know whether the error in my openldap output
is openldap related or proftpd related.
I would very much appreciate someone taking a look at the following
ouput from openldap to determine why login to proftpd is failing.
Thankyou for any help,
Kristina
LOGIN USER****************************
cn=posixtest2,o=fsas,c=JP
objectclass=top
objectclass=person
objectclass=OrganizationalPerson
objectclass=InetOrgPerson
objectclass=posixAccount
uid=posixtest2
userpassword=pass123
cn=posixtest2
sn=posixtest2
givenname=posixtest2
uidnumber=140
gidnumber=150
homedirectory=/home/posixtest2
***OUTPUT FROM OPENLDAP (Please look at the error at the very bottom********
select activity on 1 descriptors
new connection on 5
activity on:
listening for connections on 3, activity on: 5r
before select active_threads 0
select activity on 1 descriptors
activity on: 5r
read activity on 5
ber_get_next
ber_get_next: tag 0x30 len 37 contents:
ber_dump: buf 0xa4fd8, ptr 0xa4fd8, end 0xa4ffd
current len 37, contents:
02 01 01 ` 20 02 01 02 04 15 c n = r o o
t , 20 o = f s a s , 20 c = J P 80
04 f s a s
do_bind
do_bind: version 2 dn (cn=root, o=fsas, c=JP) method 128
==> ldbm_back_bind: dn: CN=ROOT,O=FSAS,C=JP
dn2entry_r: dn: "CN=ROOT,O=FSAS,C=JP"
=> dn2id( "CN=ROOT,O=FSAS,C=JP" )
=> ldbm_cache_open( "/usr/local/LDBM//dn2id.dbb", 7, 600 )
ldbm_cache_open (blksize 8192) (maxids 2046) (maxindirect 2)
<= ldbm_cache_open (opened 0)
<= dn2id 2
=> id2entry_r( 2 )
=> ldbm_cache_open( "/usr/local/LDBM//id2entry.dbb", 7, 600 )
ldbm_cache_open (blksize 8192) (maxids 2046) (maxindirect 2)
<= ldbm_cache_open (opened 1)
=> str2entry
<= str2entry 0xa1fd0
entry_rdwr_rlock: ID: 2
<= id2entry_r( 2 ) (disk)
====> cache_return_entry_r
entry_rdwr_runlock: ID: 2
do_bind: bound "cn=root, o=fsas, c=JP" to "cn=root, o=fsas, c=JP"
send_ldap_result 0::
ber_flush: 14 bytes to sd 5
0 0c 02 01 01 a 07 0a 01 00 04 00 04 00
listening for connections on 3, activity on: 5r
before select active_threads 0
select activity on 1 descriptors
activity on: 5r
read activity on 5
ber_get_next
ber_get_next: tag 0x30 len 141 contents:
ber_dump: buf 0xa1eb0, ptr 0xa1eb0, end 0xa1f3d
current len 141, contents:
02 01 02 c 81 87 04 0c o = f s a s , 20
c = J P 0a 01 02 0a 01 00 02 01 00 02 01 00
01 01 00 a0 0 a3 11 04 03 u i d 04 0a p o
s i x t e s t 2 a3 1b 04 0b o b j e
c t c l a s s 04 0c p o s i x A c
c o u n t 0 6 04 03 u i d 04 09 u i
d N u m b e r 04 09 g i d N u m b
e r 04 0d h o m e D i r e c t o r
y 04 0a l o g i n S h e l l
do_search
SRCH "O=FSAS,C=JP" 2 0 0 0 0
begin get_filter
AND
begin get_filter_list
begin get_filter
EQUALITY
end get_filter 0
begin get_filter
EQUALITY
end get_filter 0
end get_filter_list
end get_filter 0
filter: (&(uid=POSIXTEST2)(objectclass=POSIXACCOUNT))
attrs: uid uidnumber gidnumber homedirectory loginshell
=> ldbm_back_search
using base "O=FSAS,C=JP"
subtree_candidates: base: "O=FSAS,C=JP" lookupbase
dn2entry_r: dn: "O=FSAS,C=JP"
=> dn2id( "O=FSAS,C=JP" )
=> ldbm_cache_open( "/usr/local/LDBM//dn2id.dbb", 7, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id 1
=> id2entry_r( 1 )
=> ldbm_cache_open( "/usr/local/LDBM//id2entry.dbb", 7, 600 )
<= ldbm_cache_open (cache 1)
=> str2entry
<= str2entry 0xa26b0
entry_rdwr_rlock: ID: 1
<= id2entry_r( 1 ) (disk)
====> cache_return_entry_r
entry_rdwr_runlock: ID: 1
=> filter_candidates
OR
=> list_candidates 0xa1
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "objectclass" "=" "REFERRAL" )
=> ldbm_cache_open( "/usr/local/LDBM//objectclass.dbb", 7, 600 )
ldbm_cache_open (blksize 8192) (maxids 2046) (maxindirect 2)
<= ldbm_cache_open (opened 2)
<= index_read 0 candidates
<= ava_candidates 0
<= filter_candidates 0
=> filter_candidates
AND
=> list_candidates 0xa0
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "uid" "=" "POSIXTEST2" )
<= index_read 6 candidates (allids - not indexed)
<= ava_candidates 6
<= filter_candidates 6
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "objectclass" "=" "POSIXACCOUNT" )
=> ldbm_cache_open( "/usr/local/LDBM//objectclass.dbb", 7, 600 )
<= ldbm_cache_open (cache 2)
<= index_read 4 candidates
<= ava_candidates 4
<= filter_candidates 4
<= list_candidates 4
<= filter_candidates 4
<= list_candidates 4
<= filter_candidates 4
=> id2entry_r( 2 )
====> cache_find_entry_dn2id: found id: 2 rw: 0
entry_rdwr_rtrylock: ID: 2
<= id2entry_r 0xa1fd0 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (cn=root,o=fsas,c=JP) attr (uid)
=> acl_get: entry (cn=root,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=root,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=root,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 2
=> id2entry_r( 3 )
=> ldbm_cache_open( "/usr/local/LDBM//id2entry.dbb", 7, 600 )
<= ldbm_cache_open (cache 1)
=> str2entry
<= str2entry 0x111bc8
entry_rdwr_rlock: ID: 3
<= id2entry_r( 3 ) (disk)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (uid=posixtest1,o=fsas,c=JP) attr (uid)
=> acl_get: entry (uid=posixtest1,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "uid=posixtest1,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (uid=posixtest1,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 3
=> id2entry_r( 4 )
=> ldbm_cache_open( "/usr/local/LDBM//id2entry.dbb", 7, 600 )
<= ldbm_cache_open (cache 1)
=> str2entry
<= str2entry 0x112050
entry_rdwr_rlock: ID: 4
<= id2entry_r( 4 ) (disk)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= test_filter 0
=> test_filter
EQUALITY
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXACCOUNT" by
"CN=ROOT,O=FSAS,
C=JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
<= test_filter 0
<= test_filter_list 0
<= test_filter 0
=> send_search_entry (cn=posixtest2,o=fsas,c=JP)
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (entry)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (entry)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (entry)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uidnumber)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (gidnumber)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (homedirectory)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
ber_flush: 135 bytes to sd 5
0 81 84 02 01 02 d 7f 04 19 c n = p o s
i x t e s t 2 , o = f s a s , c
= J P 0 b 0 13 04 03 u i d 1 0c 04 0a
p o s i x t e s t 2 0 12 04 09 u i
d n u m b e r 1 05 04 03 1 4 0 0 12
04 09 g i d n u m b e r 1 05 04 03 1
5 0 0 # 04 0d h o m e d i r e c t
o r y 1 12 04 10 / h o m e / p o s
i x t e s t 2
<= send_search_entry
====> cache_return_entry_r
entry_rdwr_runlock: ID: 4
=> id2entry_r( 5 )
=> ldbm_cache_open( "/usr/local/LDBM//id2entry.dbb", 7, 600 )
<= ldbm_cache_open (cache 1)
=> str2entry
<= str2entry 0x111a88
entry_rdwr_rlock: ID: 5
<= id2entry_r( 5 ) (disk)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (uid=posixtest3,o=fsas,c=JP) attr (uid)
=> acl_get: entry (uid=posixtest3,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "uid=posixtest3,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (uid=posixtest3,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 5
listening for connections on 3, activity on: 5r
before select active_threads 1
send_ldap_result 0::
ber_flush: 14 bytes to sd 5
0 0c 02 01 02 e 07 0a 01 00 04 00 04 00
select activity on 1 descriptors
activity on: 5r
read activity on 5
ber_get_next
ber_get_next: tag 0x30 len 141 contents:
ber_dump: buf 0x111b08, ptr 0x111b08, end 0x111b95
current len 141, contents:
02 01 03 c 81 87 04 0c o = f s a s , 20
c = J P 0a 01 02 0a 01 00 02 01 00 02 01 00
01 01 00 a0 0 a3 11 04 03 u i d 04 0a p o
s i x t e s t 2 a3 1b 04 0b o b j e
c t c l a s s 04 0c p o s i x A c
c o u n t 0 6 04 03 u i d 04 09 u i
d N u m b e r 04 09 g i d N u m b
e r 04 0d h o m e D i r e c t o r
y 04 0a l o g i n S h e l l
do_search
SRCH "O=FSAS,C=JP" 2 0 0 0 0
begin get_filter
AND
begin get_filter_list
begin get_filter
EQUALITY
end get_filter 0
begin get_filter
EQUALITY
end get_filter 0
end get_filter_list
end get_filter 0
filter: (&(uid=POSIXTEST2)(objectclass=POSIXACCOUNT))
attrs: uid uidnumber gidnumber homedirectory loginshell
=> ldbm_back_search
using base "O=FSAS,C=JP"
subtree_candidates: base: "O=FSAS,C=JP" lookupbase
dn2entry_r: dn: "O=FSAS,C=JP"
=> dn2id( "O=FSAS,C=JP" )
====> cache_find_entry_dn2id: found dn: O=FSAS,C=JP
<= dn2id 1 (in cache)
=> id2entry_r( 1 )
====> cache_find_entry_dn2id: found id: 1 rw: 0
entry_rdwr_rtrylock: ID: 1
<= id2entry_r 0xa26b0 (cache)
====> cache_return_entry_r
entry_rdwr_runlock: ID: 1
=> filter_candidates
OR
=> list_candidates 0xa1
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "objectclass" "=" "REFERRAL" )
=> ldbm_cache_open( "/usr/local/LDBM//objectclass.dbb", 7, 600 )
<= ldbm_cache_open (cache 2)
<= index_read 0 candidates
<= ava_candidates 0
<= filter_candidates 0
=> filter_candidates
AND
=> list_candidates 0xa0
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "uid" "=" "POSIXTEST2" )
<= index_read 6 candidates (allids - not indexed)
<= ava_candidates 6
<= filter_candidates 6
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "objectclass" "=" "POSIXACCOUNT" )
=> ldbm_cache_open( "/usr/local/LDBM//objectclass.dbb", 7, 600 )
<= ldbm_cache_open (cache 2)
<= index_read 4 candidates
<= ava_candidates 4
<= filter_candidates 4
<= list_candidates 4
<= filter_candidates 4
<= list_candidates 4
<= filter_candidates 4
=> id2entry_r( 2 )
====> cache_find_entry_dn2id: found id: 2 rw: 0
entry_rdwr_rtrylock: ID: 2
<= id2entry_r 0xa1fd0 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (cn=root,o=fsas,c=JP) attr (uid)
=> acl_get: entry (cn=root,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=root,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=root,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 2
listening for connections on 3, activity on: 5r
before select active_threads 1
=> id2entry_r( 3 )
====> cache_find_entry_dn2id: found id: 3 rw: 0
entry_rdwr_rtrylock: ID: 3
<= id2entry_r 0x111bc8 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (uid=posixtest1,o=fsas,c=JP) attr (uid)
=> acl_get: entry (uid=posixtest1,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "uid=posixtest1,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (uid=posixtest1,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 3
=> id2entry_r( 4 )
====> cache_find_entry_dn2id: found id: 4 rw: 0
entry_rdwr_rtrylock: ID: 4
<= id2entry_r 0x112050 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= test_filter 0
=> test_filter
EQUALITY
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXACCOUNT" by
"CN=ROOT,O=FSAS,
C=JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
<= test_filter 0
<= test_filter_list 0
<= test_filter 0
=> send_search_entry (cn=posixtest2,o=fsas,c=JP)
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (entry)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (entry)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (entry)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uidnumber)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (gidnumber)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (homedirectory)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
ber_flush: 135 bytes to sd 5
0 81 84 02 01 03 d 7f 04 19 c n = p o s
i x t e s t 2 , o = f s a s , c
= J P 0 b 0 13 04 03 u i d 1 0c 04 0a
p o s i x t e s t 2 0 12 04 09 u i
d n u m b e r 1 05 04 03 1 4 0 0 12
04 09 g i d n u m b e r 1 05 04 03 1
5 0 0 # 04 0d h o m e d i r e c t
o r y 1 12 04 10 / h o m e / p o s
i x t e s t 2
<= send_search_entry
====> cache_return_entry_r
entry_rdwr_runlock: ID: 4
=> id2entry_r( 5 )
====> cache_find_entry_dn2id: found id: 5 rw: 0
entry_rdwr_rtrylock: ID: 5
<= id2entry_r 0x111a88 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (uid=posixtest3,o=fsas,c=JP) attr (uid)
=> acl_get: entry (uid=posixtest3,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "uid=posixtest3,o=fsas,c=JP"
select activity on 1 descriptors
activity on: 5r
read activity on 5
ber_get_next
ber_get_next: tag 0x30 len 141 contents:
ber_dump: buf 0x1126d8, ptr 0x1126d8, end 0x112765
current len 141, contents:
02 01 04 c 81 87 04 0c o = f s a s , 20
c = J P 0a 01 02 0a 01 00 02 01 00 02 01 00
01 01 00 a0 0 a3 11 04 03 u i d 04 0a p o
s i x t e s t 2 a3 1b 04 0b o b j e
c t c l a s s 04 0c p o s i x A c
c o u n t 0 6 04 03 u i d 04 09 u i
d N u m b e r 04 09 g i d N u m b
e r 04 0d h o m e D i r e c t o r
y 04 0a l o g i n S h e l l
do_search
SRCH "O=FSAS,C=JP" 2 0 0 0 0
begin get_filter
AND
begin get_filter_list
begin get_filter
EQUALITY
end get_filter 0
begin get_filter
EQUALITY
end get_filter 0
end get_filter_list
end get_filter 0
filter: (&(uid=POSIXTEST2)(objectclass=POSIXACCOUNT))
attrs: uid uidnumber gidnumber homedirectory loginshell
=> ldbm_back_search
using base "O=FSAS,C=JP"
subtree_candidates: base: "O=FSAS,C=JP" lookupbase
dn2entry_r: dn: "O=FSAS,C=JP"
=> dn2id( "O=FSAS,C=JP" )
====> cache_find_entry_dn2id: found dn: O=FSAS,C=JP
<= dn2id 1 (in cache)
=> id2entry_r( 1 )
====> cache_find_entry_dn2id: found id: 1 rw: 0
entry_rdwr_rtrylock: ID: 1
<= id2entry_r 0xa26b0 (cache)
====> cache_return_entry_r
entry_rdwr_runlock: ID: 1
=> filter_candidates
OR
=> list_candidates 0xa1
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "objectclass" "=" "REFERRAL" )
=> ldbm_cache_open( "/usr/local/LDBM//objectclass.dbb", 7, 600 )
<= ldbm_cache_open (cache 2)
<= index_read 0 candidates
<= ava_candidates 0
<= filter_candidates 0
=> filter_candidates
AND
=> list_candidates 0xa0
listening for connections on 3, activity on: 5r
before select active_threads 2
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (uid=posixtest3,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 5
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "uid" "=" "POSIXTEST2" )
<= index_read 6 candidates (allids - not indexed)
<= ava_candidates 6
<= filter_candidates 6
=> filter_candidates
EQUALITY
=> ava_candidates 0xa3
=> index_read( "objectclass" "=" "POSIXACCOUNT" )
=> ldbm_cache_open( "/usr/local/LDBM//objectclass.dbb", 7, 600 )
<= ldbm_cache_open (cache 2)
<= index_read 4 candidates
<= ava_candidates 4
<= filter_candidates 4
<= list_candidates 4
<= filter_candidates 4
<= list_candidates 4
<= filter_candidates 4
=> id2entry_r( 2 )
====> cache_find_entry_dn2id: found id: 2 rw: 0
entry_rdwr_rtrylock: ID: 2
<= id2entry_r 0xa1fd0 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (cn=root,o=fsas,c=JP) attr (uid)
=> acl_get: entry (cn=root,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=root,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=root,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 2
send_ldap_result 0::
ber_flush: 14 bytes to sd 5
0 0c 02 01 03 e 07 0a 01 00 04 00 04 00
=> id2entry_r( 3 )
====> cache_find_entry_dn2id: found id: 3 rw: 0
entry_rdwr_rtrylock: ID: 3
<= id2entry_r 0x111bc8 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (uid=posixtest1,o=fsas,c=JP) attr (uid)
=> acl_get: entry (uid=posixtest1,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "uid=posixtest1,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (uid=posixtest1,o=fsas,c=JP) attr (uid)
<= test_filter 1
<= test_filter_list 1
<= test_filter 1
====> cache_return_entry_r
entry_rdwr_runlock: ID: 3
=> id2entry_r( 4 )
====> cache_find_entry_dn2id: found id: 4 rw: 0
select activity on 1 descriptors
activity on: 5r
read activity on 5
ber_get_next
ber_get_next on fd 5 failed errno 0 (Error 0)
*** got 0 of 0 so far
listening for connections on 3, activity on:
before select active_threads 1
entry_rdwr_rtrylock: ID: 4
<= id2entry_r 0x112050 (cache)
=> test_filter
AND
=> test_filter_list
=> test_filter
EQUALITY
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXTEST2" by
"CN=ROOT,O=FSAS,C=
JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= test_filter 0
=> test_filter
EQUALITY
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: search access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: search access to value "POSIXACCOUNT" by
"CN=ROOT,O=FSAS,
C=JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (objectclass)
<= test_filter 0
<= test_filter_list 0
<= test_filter 0
=> send_search_entry (cn=posixtest2,o=fsas,c=JP)
=> access_allowed: entry (cn=posixtest2,o=fsas,c=JP) attr (entry)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (entry)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> access_allowed: exit (cn=posixtest2,o=fsas,c=JP) attr (entry)
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uid)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (uidnumber)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (gidnumber)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
=> acl_get: entry (cn=posixtest2,o=fsas,c=JP) attr (homedirectory)
<= acl_get: no acl applicable to database root
=> acl_access_allowed: read access to entry "cn=posixtest2,o=fsas,c=JP"
=> acl_access_allowed: read access to value "any" by "CN=ROOT,O=FSAS,C=JP"
<= acl_access_allowed: granted to database root
ber_flush: 135 bytes to sd -1
0 81 84 02 01 04 d 7f 04 19 c n = p o s
i x t e s t 2 , o = f s a s , c
= J P 0 b 0 13 04 03 u i d 1 0c 04 0a
p o s i x t e s t 2 0 12 04 09 u i
d n u m b e r 1 05 04 03 1 4 0 0 12
04 09 g i d n u m b e r 1 05 04 03 1
5 0 0 # 04 0d h o m e d i r e c t
o r y 1 12 04 10 / h o m e / p o s
i x t e s t 2
ber_flush failed errno 9 msg (Bad file number)
====> cache_return_entry_r
entry_rdwr_runlock: ID: 4
****************************