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

Uknown results when adding to directory



Hello!

Here is my situation.  I am using my ldap for authentication.  I am writing a 
program which will add stuff to ldap.  If I hardcode the values into the 
program, everything goes well and the entries are added to the ldap without 
problems.  If I obtain the entries from ENV variables something weird happens 
and the entries are not added.  Below is the log from when I was attempting to 
add a user.  I do not understand them unfortunately.  I believe I got the whole 
transaction. 

I also took a log of when I got a successful addition to the ldap and the logs 
definately do look different but nothing sticks out to me.

Thank you for any help!

-----------START LOG----------------------
Aug 31 02:03:42 zeus slapd[2275]: ldbm_search: candidate 897 does not match 
filter
Aug 31 02:03:43 zeus slapd[2275]: ====> cache_return_entry_r( 897 ): returned 
(0)
Aug 31 02:03:43 zeus slapd[2275]: send_ldap_search_result 0::
Aug 31 02:03:43 zeus slapd[2275]: send_ldap_response: msgid=3 tag=101 err=0
Aug 31 02:03:43 zeus slapd[2146]: connection_get(14): got connid=64
Aug 31 02:03:43 zeus slapd[2146]: connection_read(14): checking for input on 
id=64
Aug 31 02:03:43 zeus slapd[2146]: ber_get_next on fd 14 failed errno=0 (Success)
Aug 31 02:03:43 zeus slapd[2146]: connection_read(14): input error=-2 id=64, 
closing.
Aug 31 02:03:43 zeus slapd[2146]: connection_closing: readying conn=64 sd=14 
for close
Aug 31 02:03:43 zeus slapd[2146]: connection_close: conn=64 sd=14
Aug 31 02:03:50 zeus slapd[2146]: connection_get(13): got connid=65
Aug 31 02:03:50 zeus slapd[2146]: connection_read(13): checking for input on 
id=65
Aug 31 02:03:50 zeus slapd[2146]: ber_get_next on fd 13 failed errno=11 
(Resource temporarily unavailable)
Aug 31 02:03:50 zeus slapd[2149]: do_bind
Aug 31 02:03:50 zeus slapd[2149]: do_bind: version=2 
dn="cn=root,dc=birddog,dc=com" method=128
Aug 31 02:03:50 zeus slapd[2149]: dn2entry_r: dn: "CN=ROOT,DC=BIRDDOG,DC=COM"
Aug 31 02:03:50 zeus slapd[2149]: => dn2id( "CN=ROOT,DC=BIRDDOG,DC=COM" )
Aug 31 02:03:50 zeus slapd[2149]: => ldbm_cache_open( "/home/openldap/birddog-
ldbm/dn2id.dbb", 7, 600 )
Aug 31 02:03:50 zeus slapd[2149]: <= ldbm_cache_open (cache 0)
Aug 31 02:03:50 zeus slapd[2149]: <= dn2id NOID
Aug 31 02:03:50 zeus slapd[2149]: dn2entry_r: dn: "DC=BIRDDOG,DC=COM"
Aug 31 02:03:50 zeus slapd[2149]: => dn2id( "DC=BIRDDOG,DC=COM" )
Aug 31 02:03:50 zeus slapd[2149]: ====> cache_find_entry_dn2id
("DC=BIRDDOG,DC=COM"): 1 (1 tries)
Aug 31 02:03:50 zeus slapd[2149]: <= dn2id 1 (in cache)
Aug 31 02:03:50 zeus slapd[2149]: => id2entry_r( 1 )
Aug 31 02:03:50 zeus slapd[2149]: ====> cache_find_entry_id( 1 ) "dc=birddog, 
dc=com" (found) (1 tries)
Aug 31 02:03:50 zeus slapd[2149]: <= id2entry_r( 1 ) 0x80f0f18 (cache)
Aug 31 02:03:50 zeus slapd[2149]: ====> cache_return_entry_r( 1 ): returned (0)
Aug 31 02:03:50 zeus slapd[2149]: do_bind: v2 bind: "cn=root,dc=birddog,dc=com" 
to "cn=root,dc=birddog,dc=com"
Aug 31 02:03:50 zeus slapd[2149]: send_ldap_result: conn=65 op=0 p=2
Aug 31 02:03:50 zeus slapd[2149]: send_ldap_response: msgid=1 tag=97 err=0
Aug 31 02:03:50 zeus slapd[2146]: connection_get(13): got connid=65
Aug 31 02:03:50 zeus slapd[2146]: connection_read(13): checking for input on 
id=65
Aug 31 02:03:50 zeus slapd[2146]: ber_get_next on fd 13 failed errno=11 
(Resource temporarily unavailable)
Aug 31 02:03:50 zeus slapd[2164]: do_add
Aug 31 02:03:50 zeus slapd[2164]: dn2entry_r: 
dn: "UID=JOMAMA,OU=PEOPLE,DC=BIRDDOG,DC=COM"
Aug 31 02:03:50 zeus slapd[2164]: => dn2id
( "UID=JOMAMA,OU=PEOPLE,DC=BIRDDOG,DC=COM" )
Aug 31 02:03:50 zeus slapd[2164]: => ldbm_cache_open( "/home/openldap/birddog-
ldbm/dn2id.dbb", 7, 600 )
Aug 31 02:03:50 zeus slapd[2164]: <= ldbm_cache_open (cache 0)
Aug 31 02:03:50 zeus slapd[2164]: <= dn2id NOID
Aug 31 02:03:50 zeus slapd[2164]: dn2entry_r: dn: "OU=PEOPLE,DC=BIRDDOG,DC=COM"
Aug 31 02:03:50 zeus slapd[2164]: => dn2id( "OU=PEOPLE,DC=BIRDDOG,DC=COM" )
Aug 31 02:03:50 zeus slapd[2164]: ====> cache_find_entry_dn2id
("OU=PEOPLE,DC=BIRDDOG,DC=COM"): 840 (1 tries)
Aug 31 02:03:50 zeus slapd[2164]: <= dn2id 840 (in cache)
Aug 31 02:03:50 zeus slapd[2164]: => id2entry_r( 840 )
Aug 31 02:03:50 zeus slapd[2164]: ====> cache_find_entry_id( 
840 ) "ou=People,dc=birddog,dc=com" (found) (1 tries)
Aug 31 02:03:50 zeus slapd[2164]: <= id2entry_r( 840 ) 0x80f1460 (cache)
Aug 31 02:03:50 zeus slapd[2164]: ldbm_referrals: op=104 
target="uid=jomama,ou=People,dc=birddog,dc=com" 
matched="ou=People,dc=birddog,dc=com"
Aug 31 02:03:50 zeus slapd[2164]: ====> cache_return_entry_r( 840 ): returned 
(0)
Aug 31 02:03:50 zeus slapd[2164]: send_ldap_result: conn=65 op=1 p=2
Aug 31 02:03:50 zeus slapd[2164]: send_ldap_response: msgid=2 tag=105 err=21
Aug 31 02:03:50 zeus slapd[2146]: connection_get(13): got connid=65
Aug 31 02:03:50 zeus slapd[2146]: connection_read(13): checking for input on 
id=65
Aug 31 02:03:50 zeus slapd[2146]: ber_get_next on fd 13 failed errno=0 (Success)
Aug 31 02:03:50 zeus slapd[2146]: connection_read(13): input error=-2 id=65, 
closing.
Aug 31 02:03:50 zeus slapd[2146]: connection_closing: readying conn=65 sd=13 
for close
Aug 31 02:03:50 zeus slapd[2146]: connection_close: conn=65 sd=13
Aug 31 02:03:55 zeus slapd[2146]: connection_get(13): got connid=66
Aug 31 02:03:55 zeus slapd[2146]: connection_read(13): checking for input on 
id=66
Aug 31 02:03:55 zeus slapd[2146]: ber_get_next on fd 13 failed errno=11 
(Resource temporarily unavailable)
Aug 31 02:03:55 zeus slapd[2314]: do_bind
Aug 31 02:03:55 zeus slapd[2314]: do_bind: version=3 dn="" method=128
Aug 31 02:03:55 zeus slapd[2314]: send_ldap_result: conn=66 op=0 p=3
Aug 31 02:03:55 zeus slapd[2314]: send_ldap_response: msgid=1 tag=97 err=0
Aug 31 02:03:55 zeus slapd[2314]: do_bind: v3 anonymous bind
Aug 31 02:03:55 zeus slapd[2146]: connection_get(13): got connid=66
Aug 31 02:03:55 zeus slapd[2146]: connection_read(13): checking for input on 
id=66
Aug 31 02:03:55 zeus slapd[2146]: ber_get_next on fd 13 failed errno=11 
(Resource temporarily unavailable)
Aug 31 02:03:55 zeus slapd[2275]: do_search
Aug 31 02:03:55 zeus slapd[2275]: => ldbm_back_search
Aug 31 02:03:55 zeus slapd[2275]: dn2entry_r: 
dn: "OU=EMPLOYEES,DC=BIRDDOG,DC=COM"
Aug 31 02:03:55 zeus slapd[2275]: => dn2id( "OU=EMPLOYEES,DC=BIRDDOG,DC=COM" )
Aug 31 02:03:55 zeus slapd[2275]: => ldbm_cache_open( "/home/openldap/birddog-
ldbm/dn2id.dbb", 7, 600 )
Aug 31 02:03:55 zeus slapd[2275]: <= ldbm_cache_open (cache 0)
Aug 31 02:03:55 zeus slapd[2275]: <= dn2id NOID
Aug 31 02:03:55 zeus slapd[2275]: dn2entry_r: dn: "DC=BIRDDOG,DC=COM"
Aug 31 02:03:55 zeus slapd[2275]: => dn2id( "DC=BIRDDOG,DC=COM" )
Aug 31 02:03:55 zeus slapd[2275]: ====> cache_find_entry_dn2id
("DC=BIRDDOG,DC=COM"): 1 (1 tries)
Aug 31 02:03:55 zeus slapd[2275]: <= dn2id 1 (in cache)
Aug 31 02:03:55 zeus slapd[2275]: => id2entry_r( 1 )
Aug 31 02:03:55 zeus slapd[2275]: ====> cache_find_entry_id( 1 ) "dc=birddog, 
dc=com" (found) (1 tries)
Aug 31 02:03:55 zeus slapd[2275]: <= id2entry_r( 1 ) 0x80f0f18 (cache)
Aug 31 02:03:55 zeus slapd[2275]: ====> cache_return_entry_r( 1 ): returned (0)
Aug 31 02:03:55 zeus slapd[2275]: send_ldap_result: conn=66 op=1 p=3
Aug 31 02:03:55 zeus slapd[2275]: send_ldap_response: msgid=2 tag=101 err=32
-----------------END LOG--------------------------------------

-- 
Terry Davis
Systems Administrator
BirdDog Solutions, Inc.
(402) 829-6059





-------------------------------------------------
This mail sent through IMP: http://horde.org/imp/