Brodie, Kent wrote: > Rich: Thanks for the debugging help! I'm still stuck, as I am not > sure exactly what I am looking at in terms of messages. I can see that > the same uniqueid 4922d291-be7a11de-adce9eef-94681f9f keeps failing, but > the message surrounding that error are anything but clear to me. > Try using the /usr/bin/cl-dump tool to dump the changelog (man cl-dump) - look for uniqueid 4922d291-be7a11de-adce9eef-94681f9f and dn="uid=jgretzon,ou=spine,dc=hmgc,dc=mcw,dc=edu" and csn=4ae06697000000020000 > Can someone help look at this and translate what's going on? The log > below is about 5 mins worth. > > > [22/Oct/2009:09:36:08 -0500] - Fedora-Directory/1.2.0 B2009.118.181 > starting up > [22/Oct/2009:09:36:08 -0500] NSMMReplicationPlugin - changelog program - > _cl5CheckGuardian: found old style of guardian file: > bdb/4.3/libreplication-plugin > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - changelog program - > _cl5NewDBFile: semaphore > /var/lib/dirsrv/slapd-white/changelogdb/f2291084-807511de-837b9eef-94681 > f9f.sema > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - changelog program - > _cl5NewDBFile: maxConcurrentWrites=2 > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - changelog program - > _cl5GetEntryCount: 500 changes for replica > f2291084-807511de-837b9eef-94681f9f > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - changelog program - > _cl5AddDBFile: Added new DB object 13901670 > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - changelog program - > _cl5DBOpenFileByReplicaName: created new DB object 13901670 > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - changelog program - > _cl5DBOpen: opened 1 existing databases in > /var/lib/dirsrv/slapd-white/changelogdb > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - Found replication > agreement named "cn="Replication to > winters.hmgc.mcw.edu",cn=replica,cn="dc=hmgc, dc=mcw, dc=edu",cn=mapping > tree,cn=config". > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - > agmtlist_config_init: found 1 replication agreements in DIT > [22/Oct/2009:09:36:09 -0500] NSMMReplicationPlugin - changelog program - > _cl5GetDBFile: found DB object 13901670 for database > f2291084-807511de-837b9eef-94681f9f_4a7758f2000000010000.db4 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): No linger > to cancel on the connection > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Disconnected from the consumer > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > start -> ready_to_acquire_replica > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Trying > non-secure slapi_ldap_init_ext > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): binddn = > cn=repman,cn=config, passwd = {DES}0U0krPfv0gLunf3SATmXQw== > [22/Oct/2009:09:36:10 -0500] - _csngen_adjust_local_time: gen state > before 4ae06db60001:1256222132:0:2 > [22/Oct/2009:09:36:10 -0500] - _csngen_adjust_local_time: gen state > after 4ae06ddc0000:1256222170:0:2 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): No linger > to cancel on the connection > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > ruv_add_csn_inprogress: successfully inserted csn 4ae06ddc000000020000 > into pending list > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - Purged state > information from entry dc=hmgc, dc=mcw, dc=edu up to CSN > 4ad72c1e000000020000 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > csn=4ae06ddc000000020000 process postop: canceling operation csn > [22/Oct/2009:09:36:10 -0500] - slapd started. Listening on All > Interfaces port 389 for LDAP requests > [22/Oct/2009:09:36:10 -0500] - Listening on All Interfaces port 636 for > LDAPS requests > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Replica > was successfully acquired. > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > ready_to_acquire_replica -> sending_updates > [22/Oct/2009:09:36:10 -0500] - csngen_adjust_time: gen state before > 4ae06ddc0002:1256222170:0:2 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - changelog program - > _cl5GetDBFile: found DB object 13901670 for database > f2291084-807511de-837b9eef-94681f9f_4a7758f2000000010000.db4 > [22/Oct/2009:09:36:10 -0500] - _cl5PositionCursorForReplay > (agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389)): > Consumer RUV: > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > {replicageneration} 4a7758f2000000010000 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 1 ldap://winters.hmgc.mcw.edu:389} 4a799281000000010000 > 4adf7830000100010000 00000000 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 2 ldap://white.hmgc.mcw.edu:389} 4a78849d000000020000 > 4ae0612d000300020000 00000000 > [22/Oct/2009:09:36:10 -0500] - _cl5PositionCursorForReplay > (agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389)): > Supplier RUV: > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > {replicageneration} 4a7758f2000000010000 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 2 ldap://white.hmgc.mcw.edu:389} 4a78849d000000020000 > 4ae0669e000000020000 00000000 > [22/Oct/2009:09:36:10 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 1 ldap://winters.hmgc.mcw.edu:389} 4a799281000000010000 > 4adf7830000100010000 00000000 > [22/Oct/2009:09:36:10 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - session start: > anchorcsn=4ae0612d000300020000 > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - changelog program - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): CSN > 4ae0612d000300020000 found, position set for replay > [22/Oct/2009:09:36:11 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - load=1 rec=1 > csn=4ae06697000000020000 > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Sending modify operation > (dn="uid=jgretzon,ou=spine,dc=hmgc,dc=mcw,dc=edu" > csn=4ae06697000000020000) > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Consumer successfully sent operation with csn > 4ae06697000000020000 > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain starting > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: result 3, > 53, 1, 6, (null) > [22/Oct/2009:09:36:11 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - load=1 rec=2 > csn=4ae0669e000000020000 > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Sending modify operation > (dn="uid=jgretzon,ou=spine,dc=hmgc,dc=mcw,dc=edu" > csn=4ae0669e000000020000) > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Consumer > failed to replay change (uniqueid 4922d291-be7a11de-adce9eef-94681f9f, > CSN 4ae06697000000020000): DSA is unwilling to perform. Will retry > later. > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Consumer successfully sent operation with csn > 4ae0669e000000020000 > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: got op > result 202 should finish 1 > [22/Oct/2009:09:36:11 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - clcache_load_buffer: rc=-30989 > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): No more > updates to send (cl5GetNextOperationToReplay) > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: result 3, > 53, 1, 7, (null) > [22/Oct/2009:09:36:11 -0500] - repl5_inc_waitfor_async_results: 7 7 > [22/Oct/2009:09:36:11 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Consumer > failed to replay change (uniqueid 4922d291-be7a11de-adce9eef-94681f9f, > CSN 4ae0669e000000020000): DSA is unwilling to perform. Will retry > later. > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: got op > result 202 should finish 1 > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:11 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain: read result > for message_id 7 > [22/Oct/2009:09:36:12 -0500] - repl5_inc_result_threadmain exiting > [22/Oct/2009:09:36:12 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - session end: state=5 load=1 > sent=2 skipped=0 > [22/Oct/2009:09:36:13 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Successfully released consumer > [22/Oct/2009:09:36:14 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Beginning > linger on the connection > [22/Oct/2009:09:36:14 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > sending_updates -> wait_for_changes > [22/Oct/2009:09:37:14 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Linger > timeout has expired on the connection > [22/Oct/2009:09:37:14 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Disconnected from the consumer > > > [22/Oct/2009:09:41:14 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > wait_for_changes -> wait_for_changes > [22/Oct/2009:09:41:15 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > wait_for_changes -> start > [22/Oct/2009:09:41:15 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): No linger > to cancel on the connection > [22/Oct/2009:09:41:15 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Disconnected from the consumer > [22/Oct/2009:09:41:15 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > start -> ready_to_acquire_replica > [22/Oct/2009:09:41:15 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Trying > non-secure slapi_ldap_init_ext > [22/Oct/2009:09:41:15 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): binddn = > cn=repman,cn=config, passwd = {DES}0U0krPfv0gLunf3SATmXQw== > [22/Oct/2009:09:41:15 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): No linger > to cancel on the connection > [22/Oct/2009:09:41:15 -0500] - _csngen_adjust_local_time: gen state > before 4ae06ddc0002:1256222170:0:2 > [22/Oct/2009:09:41:15 -0500] - _csngen_adjust_local_time: gen state > after 4ae06f0d0000:1256222475:0:2 > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Replica > was successfully acquired. > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > ready_to_acquire_replica -> sending_updates > [22/Oct/2009:09:41:16 -0500] - csngen_adjust_time: gen state before > 4ae06f0d0001:1256222475:0:2 > [22/Oct/2009:09:41:16 -0500] - _csngen_adjust_local_time: gen state > before 4ae06f0d0001:1256222475:0:2 > [22/Oct/2009:09:41:16 -0500] - _csngen_adjust_local_time: gen state > after 4ae06f0e0000:1256222476:0:2 > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - changelog program - > _cl5GetDBFile: found DB object 13901670 for database > f2291084-807511de-837b9eef-94681f9f_4a7758f2000000010000.db4 > [22/Oct/2009:09:41:16 -0500] - _cl5PositionCursorForReplay > (agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389)): > Consumer RUV: > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > {replicageneration} 4a7758f2000000010000 > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 1 ldap://winters.hmgc.mcw.edu:389} 4a799281000000010000 > 4adf7830000100010000 00000000 > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 2 ldap://white.hmgc.mcw.edu:389} 4a78849d000000020000 > 4ae0612d000300020000 00000000 > [22/Oct/2009:09:41:16 -0500] - _cl5PositionCursorForReplay > (agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389)): > Supplier RUV: > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > {replicageneration} 4a7758f2000000010000 > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 2 ldap://white.hmgc.mcw.edu:389} 4a78849d000000020000 > 4ae0669e000000020000 00000000 > [22/Oct/2009:09:41:16 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 1 ldap://winters.hmgc.mcw.edu:389} 4a799281000000010000 > 4adf7830000100010000 00000000 > [22/Oct/2009:09:41:16 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - clcache_get_buffer: found thread > private buffer cache 13a76610 > [22/Oct/2009:09:41:16 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - clcache_get_buffer: _pool is > 13963c90 _pool->pl_busy_lists is 13903780 > _pool->pl_busy_lists->bl_buffers is 13a76610 > [22/Oct/2009:09:41:17 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - session start: > anchorcsn=4ae0612d000300020000 > [22/Oct/2009:09:41:17 -0500] NSMMReplicationPlugin - changelog program - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): CSN > 4ae0612d000300020000 found, position set for replay > [22/Oct/2009:09:41:17 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - load=1 rec=1 > csn=4ae06697000000020000 > [22/Oct/2009:09:41:17 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Sending modify operation > (dn="uid=jgretzon,ou=spine,dc=hmgc,dc=mcw,dc=edu" > csn=4ae06697000000020000) > [22/Oct/2009:09:41:17 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Consumer successfully sent operation with csn > 4ae06697000000020000 > [22/Oct/2009:09:41:17 -0500] - repl5_inc_result_threadmain starting > [22/Oct/2009:09:41:17 -0500] - repl5_inc_result_threadmain: read result > for message_id 5 > [22/Oct/2009:09:41:17 -0500] - repl5_inc_result_threadmain: result 3, > 53, 1, 5, (null) > [22/Oct/2009:09:41:17 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - load=1 rec=2 > csn=4ae0669e000000020000 > [22/Oct/2009:09:41:18 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Consumer > failed to replay change (uniqueid 4922d291-be7a11de-adce9eef-94681f9f, > CSN 4ae06697000000020000): DSA is unwilling to perform. Will retry > later. > [22/Oct/2009:09:41:19 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Sending modify operation > (dn="uid=jgretzon,ou=spine,dc=hmgc,dc=mcw,dc=edu" > csn=4ae0669e000000020000) > [22/Oct/2009:09:41:19 -0500] - repl5_inc_result_threadmain: got op > result 202 should finish 1 > [22/Oct/2009:09:41:19 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Consumer successfully sent operation with csn > 4ae0669e000000020000 > [22/Oct/2009:09:41:19 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:19 -0500] - repl5_inc_waitfor_async_results: 5 6 > [22/Oct/2009:09:41:19 -0500] - repl5_inc_result_threadmain: result 3, > 53, 1, 6, (null) > [22/Oct/2009:09:41:19 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Consumer > failed to replay change (uniqueid 4922d291-be7a11de-adce9eef-94681f9f, > CSN 4ae0669e000000020000): DSA is unwilling to perform. Will retry > later. > [22/Oct/2009:09:41:19 -0500] - repl5_inc_result_threadmain: got op > result 202 should finish 1 > [22/Oct/2009:09:41:19 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:19 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:19 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:20 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:20 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:20 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:20 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:20 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:20 -0500] - repl5_inc_result_threadmain: read result > for message_id 6 > [22/Oct/2009:09:41:20 -0500] - repl5_inc_result_threadmain exiting > [22/Oct/2009:09:41:20 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - session end: state=0 load=1 > sent=2 skipped=0 > [22/Oct/2009:09:41:23 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Successfully released consumer > [22/Oct/2009:09:41:23 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Beginning > linger on the connection > [22/Oct/2009:09:41:23 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > sending_updates -> start_backoff > [22/Oct/2009:09:41:26 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > start_backoff -> backoff > [22/Oct/2009:09:41:26 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Cancelling linger on the connection > [22/Oct/2009:09:41:26 -0500] - _csngen_adjust_local_time: gen state > before 4ae06f0e0000:1256222476:0:2 > [22/Oct/2009:09:41:26 -0500] - _csngen_adjust_local_time: gen state > after 4ae06f180000:1256222486:0:2 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Replica > was successfully acquired. > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > backoff -> sending_updates > [22/Oct/2009:09:41:27 -0500] - csngen_adjust_time: gen state before > 4ae06f180001:1256222486:0:2 > [22/Oct/2009:09:41:27 -0500] - _csngen_adjust_local_time: gen state > before 4ae06f180001:1256222486:0:2 > [22/Oct/2009:09:41:27 -0500] - _csngen_adjust_local_time: gen state > after 4ae06f190000:1256222487:0:2 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - changelog program - > _cl5GetDBFile: found DB object 13901670 for database > f2291084-807511de-837b9eef-94681f9f_4a7758f2000000010000.db4 > [22/Oct/2009:09:41:27 -0500] - _cl5PositionCursorForReplay > (agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389)): > Consumer RUV: > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > {replicageneration} 4a7758f2000000010000 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 1 ldap://winters.hmgc.mcw.edu:389} 4a799281000000010000 > 4adf7830000100010000 00000000 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 2 ldap://white.hmgc.mcw.edu:389} 4a78849d000000020000 > 4ae0612d000300020000 00000000 > [22/Oct/2009:09:41:27 -0500] - _cl5PositionCursorForReplay > (agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389)): > Supplier RUV: > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > {replicageneration} 4a7758f2000000010000 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 2 ldap://white.hmgc.mcw.edu:389} 4a78849d000000020000 > 4ae0669e000000020000 00000000 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): {replica > 1 ldap://winters.hmgc.mcw.edu:389} 4a799281000000010000 > 4adf7830000100010000 00000000 > [22/Oct/2009:09:41:27 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - clcache_get_buffer: found thread > private buffer cache 13a76610 > [22/Oct/2009:09:41:27 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - clcache_get_buffer: _pool is > 13963c90 _pool->pl_busy_lists is 13903780 > _pool->pl_busy_lists->bl_buffers is 13a76610 > [22/Oct/2009:09:41:27 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - session start: > anchorcsn=4ae0612d000300020000 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - changelog program - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): CSN > 4ae0612d000300020000 found, position set for replay > [22/Oct/2009:09:41:27 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - load=1 rec=1 > csn=4ae06697000000020000 > [22/Oct/2009:09:41:27 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Sending modify operation > (dn="uid=jgretzon,ou=spine,dc=hmgc,dc=mcw,dc=edu" > csn=4ae06697000000020000) > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain starting > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: read result > for message_id 9 > [22/Oct/2009:09:41:28 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Consumer successfully sent operation with csn > 4ae06697000000020000 > [22/Oct/2009:09:41:28 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - load=1 rec=2 > csn=4ae0669e000000020000 > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: result 3, > 53, 1, 9, (null) > [22/Oct/2009:09:41:28 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Sending modify operation > (dn="uid=jgretzon,ou=spine,dc=hmgc,dc=mcw,dc=edu" > csn=4ae0669e000000020000) > [22/Oct/2009:09:41:28 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Consumer > failed to replay change (uniqueid (null), CSN (null)): DSA is unwilling > to perform. Will retry later. > [22/Oct/2009:09:41:28 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > replay_update: Consumer successfully sent operation with csn > 4ae0669e000000020000 > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: got op > result 202 should finish 1 > [22/Oct/2009:09:41:28 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - clcache_load_buffer: rc=-30989 > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:28 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): No more > updates to send (cl5GetNextOperationToReplay) > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: result 3, > 53, 1, 10, (null) > [22/Oct/2009:09:41:28 -0500] - repl5_inc_waitfor_async_results: 10 10 > [22/Oct/2009:09:41:28 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Consumer > failed to replay change (uniqueid 4922d291-be7a11de-adce9eef-94681f9f, > CSN 4ae06697000000020000): DSA is unwilling to perform. Will retry > later. > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: got op > result 202 should finish 1 > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:28 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain: read result > for message_id 10 > [22/Oct/2009:09:41:29 -0500] - repl5_inc_result_threadmain exiting > [22/Oct/2009:09:41:29 -0500] agmt="cn="Replication to > winters.hmgc.mcw.edu"" (winters:389) - session end: state=5 load=1 > sent=2 skipped=0 > [22/Oct/2009:09:41:30 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Successfully released consumer > [22/Oct/2009:09:41:30 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Beginning > linger on the connection > [22/Oct/2009:09:41:30 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): State: > sending_updates -> wait_for_changes > [22/Oct/2009:09:42:30 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): Linger > timeout has expired on the connection > [22/Oct/2009:09:42:30 -0500] NSMMReplicationPlugin - > agmt="cn="Replication to winters.hmgc.mcw.edu"" (winters:389): > Disconnected from the consumer > > > [22/Oct/2009:09:46:24 -0500] - slapd shutting down - signaling operation > threads > [22/Oct/2009:09:46:24 -0500] - slapd shutting down - waiting for 29 > threads to terminate > [22/Oct/2009:09:46:24 -0500] - slapd shutting down - closing down > internal subsystems and plugins > [22/Oct/2009:09:46:26 -0500] - Waiting for 4 database threads to stop > [22/Oct/2009:09:46:27 -0500] - All database threads now stopped > [22/Oct/2009:09:46:27 -0500] - slapd stopped. > > > > > > > -- > 389 users mailing list > 389-users at redhat.com > https://www.redhat.com/mailman/listinfo/fedora-directory-users > -------------- next part -------------- A non-text attachment was scrubbed... Name: smime.p7s Type: application/x-pkcs7-signature Size: 3258 bytes Desc: S/MIME Cryptographic Signature Url : http://lists.fedoraproject.org/pipermail/389-users/attachments/20091022/a4066b65/attachment.bin