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

test007-replication failed

To: openldap-software@OpenLDAP.org
Subject: test007-replication failed
From: Hery Rakotoarisoa <Hery.Rakotoarisoa@univ-paris8.fr>
Date: Tue, 12 Sep 2000 10:57:28 GMT

Thanks for helping me on the test001 problem, starting 
/etc/init.d/cryptorand
was enough on the solaris box to run a random number generator on 
/dev/random

Yet another problem for test007-replication, master and slave
don't have the same database content after replication (was there 
really
a replication ?).

There is a « No such object (32) » in slave.out
Watching slave.log when running the test, nothing happen on the slave 
side
while slurpd is doing the following (and even afterwards) :

new work in ./test-db/slapd.replog
copy replog "./test-db/slapd.replog" to 
"./test-repl/replica/slurpd.replog"

Here are slurpd and slave logs (attached).
Other logs in another mail if necessary.

Is there a slurpd problem ?

Hery

@(#) $OpenLDAP: slapd 2.0.1-Release (Mon Sep 11 16:18:49 MET DST 2000) $
	hmr@harris:/disk1/work/webmail/openldap-2.0.1/servers/slapd
daemon_init: ldap://localhost:9010/
daemon_init: listen on ldap://localhost:9010/
daemon_init: 1 listeners to open...
ldap_url_parse(ldap://localhost:9010/)
daemon: initialized ldap://localhost:9010/
daemon_init: 1 listeners opened
slapd init: initiated server.
slap_sasl_init: initialized!
slapd startup: initiated.
slapd starting
ldap_pvt_gethostbyname_a: host=harris, r=0
connection_get(8)
connection_get(8): got connid=0
connection_read(8): checking for input on id=0
ber_get_next
ber_get_next: tag 0x30 len 60 contents:
ber_get_next
ber_get_next on fd 8 failed errno=11 (Resource temporarily unavailable)
do_bind
ber_scanf fmt ({iat) ber:
ber_scanf fmt (o}) ber:
do_bind: version=3 dn="cn=Replica, o=University of Michigan, c=US" method=128
==> ldbm_back_bind: dn: cn=Replica, o=University of Michigan, c=US
dn2entry_r: dn: "CN=REPLICA,O=UNIVERSITY OF MICHIGAN,C=US"
=> dn2id( "CN=REPLICA,O=UNIVERSITY OF MICHIGAN,C=US" )
=> ldbm_cache_open( "./test-repl/dn2id.dbb", 7, 600 )
ldbm_cache_open (blksize 8192) (maxids 2046) (maxindirect 5)
<= ldbm_cache_open (opened 0)
<= dn2id NOID
dn2entry_r: dn: "O=UNIVERSITY OF MICHIGAN,C=US"
=> dn2id( "O=UNIVERSITY OF MICHIGAN,C=US" )
=> ldbm_cache_open( "./test-repl/dn2id.dbb", 7, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
do_bind: v3 bind: "cn=Replica, o=University of Michigan, c=US" to "cn=Replica, o=University of Michigan, c=US"
send_ldap_result: conn=0 op=0 p=3
send_ldap_result: 0::
send_ldap_response: msgid=1 tag=97 err=0
ber_flush: 14 bytes to sd 8
connection_get(8)
connection_get(8): got connid=0
connection_read(8): checking for input on id=0
ber_get_next
ber_get_next: tag 0x30 len 716 contents:
ber_get_next
ber_get_next on fd 8 failed errno=11 (Resource temporarily unavailable)
do_add
ber_scanf fmt ({a) ber:
do_add: ndn (O=UNIVERSITY OF MICHIGAN,C=US)
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt ({a{V}}) ber:
ber_scanf fmt (}) ber:
=> get_ctrls
ber_scanf fmt ({a) ber:
ber_scanf fmt (b) ber:
=> get_ctrls: oid="2.16.840.1.113730.3.4.2" (critical)
<= get_ctrls: 1 0 
connection_get(10)
connection_get(10): got connid=1
connection_read(10): checking for input on id=1
ber_get_next
ber_get_next: tag 0x30 len 12 contents:
ber_get_next
ber_get_next on fd 10 failed errno=11 (Resource temporarily unavailable)
do_bind
ber_scanf fmt ({iat) ber:
ber_scanf fmt (o}) ber:
do_bind: version=3 dn="" method=128
send_ldap_result: conn=1 op=0 p=3
send_ldap_result: 0::
send_ldap_response: msgid=1 tag=97 err=0
ber_flush: 14 bytes to sd 10
do_bind: v3 anonymous bind
connection_get(10)
connection_get(10): got connid=1
connection_read(10): checking for input on id=1
ber_get_next
ber_get_next: tag 0x30 len 67 contents:
ber_get_next
ber_get_next on fd 10 failed errno=11 (Resource temporarily unavailable)
do_search
ber_scanf fmt ({aiiiib) ber:
SRCH "o=University of Michigan, c=US" 2 0    0 0 0
ber_scanf fmt (o) ber:
    filter: (objectClass=*)
ber_scanf fmt ({v}}) ber:
    attrs:
=> ldbm_back_search
dn2entry_r: dn: "O=UNIVERSITY OF MICHIGAN,C=US"
=> dn2id( "O=UNIVERSITY OF MICHIGAN,C=US" )
=> ldbm_cache_open( "./test-repl/dn2id.dbb", 7, 600 )
<= ldbm_cache_open (cache 0)
<= dn2id NOID
send_ldap_result: conn=1 op=1 p=3
send_ldap_result: 10::
send_ldap_response: msgid=2 tag=101 err=32
ber_flush: 14 bytes to sd 10
connection_get(10)
connection_get(10): got connid=1
connection_read(10): checking for input on id=1
ber_get_next
ber_get_next: tag 0x30 len 5 contents:
ber_get_next
ber_get_next on fd 10 failed errno=11 (Resource temporarily unavailable)
do_unbind
connection_closing: readying conn=1 sd=10 for close
connection_resched: attempting closing conn=1 sd=10
connection_close: conn=1 sd=10
slap_sig_shutdown: signal 1
daemon: shutdown requested and initiated.
slapd shutdown: waiting for 0 threads to terminate
slapd shutdown: initiated
ldbm backend syncing
ldbm flushing db (./test-repl/dn2id.dbb)
ldbm closing db (./test-repl/dn2id.dbb)
ldbm backend done syncing
====> cache_release_all
slapd shutdown: freeing system resources.
slapd stopped.

begin replication thread for localhost:9010
Initializing session to localhost:9010
ldap_create
bind to localhost:9010 as cn=Replica, o=University of Michigan, c=US (simple)
ldap_simple_bind_s
ldap_sasl_bind_s
ldap_sasl_bind
ldap_send_initial_request
ldap_new_connection
ldap_int_open_connection
ldap_connect_to_host
ldap_pvt_gethostbyname_a: host=localhost, r=0
ldap_new_socket: 7
ldap_prepare_socket: 7
ldap_connect_to_host: Trying 127.0.0.1:9010
ldap_connect_timeout: fd: 7 tm: -1 async: 0
ldap_ndelay_on: 7
ldap_ndelay_off: 7
ldap_int_sasl_open: harris.univ-paris8.fr
ldap_delayed_open successful, ld_host is (null)
ldap_send_server_request
ber_flush: 62 bytes to sd 7
ldap_result
wait4msg (infinite timeout)
** Connections:
* host: localhost  port: 9010  (default)
  refcnt: 2  status: Connected
  last used: Tue Sep 12 10:57:38 2000

** Outstanding Requests:
 * msgid 1,  origid 1, status InProgress
   outstanding referrals 0, parent count 0
** Response Queue:
   Empty
do_ldap_select
read1msg
ber_get_next
ber_get_next: tag 0x30 len 12 contents:
ldap_read: message type bind msgid 1, original id 1
ber_scanf fmt ({iaa) ber:
read1msg:  0 new referrals
read1msg:  mark request completed, id = 1
request 1 done
res_errno: 0, res_error: <>, res_matched: <>
ldap_free_request (origid 1, msgid 1)
ldap_free_connection
ldap_free_connection: refcnt 1
ldap_parse_result
ber_scanf fmt ({iaa) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
replica localhost:9010 - add dn "o=University of Michigan, c=US"
ldap_add
ldap_send_initial_request
ldap_send_server_request
ber_flush: 720 bytes to sd 7
ldap_result
wait4msg (infinite timeout)
** Connections:
* host: localhost  port: 9010  (default)
  refcnt: 2  status: Connected
  last used: Tue Sep 12 10:57:38 2000

** Outstanding Requests:
 * msgid 2,  origid 2, status InProgress
   outstanding referrals 0, parent count 0
** Response Queue:
   Empty
do_ldap_select
new work in ./test-db/slapd.replog
copy replog "./test-db/slapd.replog" to "./test-repl/replica/slurpd.replog"
new work in ./test-db/slapd.replog
copy replog "./test-db/slapd.replog" to "./test-repl/replica/slurpd.replog"
new work in ./test-db/slapd.replog
copy replog "./test-db/slapd.replog" to "./test-repl/replica/slurpd.replog"
fm: exiting
do_ldap_select returned -1: errno 4
** Connections:
* host: localhost  port: 9010  (default)
  refcnt: 2  status: Connected
  last used: Tue Sep 12 10:57:38 2000

** Outstanding Requests:
 * msgid 2,  origid 2, status InProgress
   outstanding referrals 0, parent count 0
** Response Queue:
   Empty
do_ldap_select
read1msg
ber_get_next
ldap_err2string
Error: ldap_add_s failed adding "Can't contact LDAP server": o=University of Michigan, c=US
ldap_unbind
ldap_free_request (origid 2, msgid 2)
ldap_free_connection
ldap_send_unbind
ber_flush: 39 bytes to sd 7
ldap_free_connection: actually freed
Initializing session to localhost:9010
ldap_create
bind to localhost:9010 as cn=Replica, o=University of Michigan, c=US (simple)
ldap_simple_bind_s
ldap_sasl_bind_s
ldap_sasl_bind
ldap_send_initial_request
ldap_new_connection
ldap_int_open_connection
ldap_connect_to_host
ldap_pvt_gethostbyname_a: host=localhost, r=0
ldap_new_socket: 5
ldap_prepare_socket: 5
ldap_connect_to_host: Trying 127.0.0.1:9010
ldap_connect_timeout: fd: 5 tm: -1 async: 0
ldap_ndelay_on: 5
ldap_close_socket: 5
ldap_err2string
Error: ldap_simple_bind_s for localhost:9010 failed: Can't contact LDAP server
ldap_unbind
Retrying operation for DN o=University of Michigan, c=US on replica localhost:9010
end replication thread for localhost:9010
slurpd: terminated.

Prev by Date: RE: Synchronizing a NT4 PDC with OpenLDAP
Next by Date: OpenLDAP2.0.1/SAMBA schemas
Index(es):
- Chronological
- Thread