[389-users] Multi-Master Replications errors

Rich Megginson rmeggins at redhat.com
Mon Jun 3 15:37:19 UTC 2013


On 06/03/2013 09:18 AM, vladimir Safoo wrote:
> Good morning all,
>
> I need some help in understanding if these errors are legit and if I 
> there is some action that I need to take.
What errors?  Why have you enabled the replication debugging log level?
>
> cat /etc/issue
> CentOS release 6.2 (Final)
> rpm -qa 389-ds*
> 389-ds-base-1.2.9.14-1.el6_2.2.x86_64
> 389-ds-console-doc-1.2.6-1.el6.noarch
> 389-ds-base-libs-1.2.9.14-1.el6_2.2.x86_64
> 389-ds-console-1.2.6-1.el6.noarch
> 389-ds-1.2.2-1.el6.noarch
> 389-dsgw-1.1.9-1.el6.x86_64
>
> ==> /var/log/dirsrv/slapd-kat-ds-02/errors <==
> [03/Jun/2013:09:37:09 -0500] NSMMReplicationPlugin - conn=62606 op=3 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:09 -0500] - csngen_adjust_time: gen state before 
> 51aca8bd0001:1370269840:1:44
> [03/Jun/2013:09:37:09 -0500] - _csngen_adjust_local_time: gen state 
> before 51aca8bd0001:1370269840:1:44
> [03/Jun/2013:09:37:09 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa410000:1370270229:0:44
> [03/Jun/2013:09:37:09 -0500] - csngen_adjust_time: gen state after 
> 51acaa410005:1370270229:0:44
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62606 op=3 
> repl="dc=company,dc=net": Acquired replica
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62606 op=3 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=0 rc=0
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62607 op=3 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - 
> ruv_add_csn_inprogress: successfully inserted csn 51acaa41000000010000 
> into pending list
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62608 op=3 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:10 -0500] - csngen_adjust_time: gen state before 
> 51acaa410005:1370270229:0:44
> [03/Jun/2013:09:37:10 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa410005:1370270229:0:44
> [03/Jun/2013:09:37:10 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa420000:1370270230:0:44
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62607 op=3 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62607 op=3 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:10 -0500] - csngen_adjust_time: gen state before 
> 51acaa420000:1370270230:0:44
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62608 op=3 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62608 op=3 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62608 op=3 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - Purged state 
> information from entry 
> uid=tuser,ou=Contractors,ou=Groups,dc=company,dc=net up to CSN 
> 51a36e2e000b00010000
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62609 op=3 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:10 -0500] - csngen_adjust_time: gen state before 
> 51acaa420000:1370270230:0:44
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62609 op=3 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62609 op=3 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62609 op=3 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - conn=62607 op=3 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - ruv_update_ruv: 
> successfully committed csn 51acaa41000000010000
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:10 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): Trying non-secure 
> slapi_ldap_init_ext
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): Trying non-secure 
> slapi_ldap_init_ext
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): binddn = cn=replication 
> manager,cn=config,  passwd = {DES}************************
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): Trying non-secure 
> slapi_ldap_init_ext
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): Trying non-secure 
> slapi_ldap_init_ext
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): binddn = cn=replication 
> manager,cn=config,  passwd = {DES}************************
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> ruv_add_csn_inprogress: successfully inserted csn 51acaa41000100010000 
> into pending list
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): No linger to cancel on 
> the connection
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): Trying non-secure 
> slapi_ldap_init_ext
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - Purged state 
> information from entry 
> uid=tuser,ou=Contractors,ou=Groups,dc=company,dc=net up to CSN 
> 51a36fc1000000010000
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): No linger to cancel on 
> the connection
> [03/Jun/2013:09:37:11 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa420000:1370270230:0:44
> [03/Jun/2013:09:37:11 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa430000:1370270231:0:44
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): binddn = cn=replication 
> manager,cn=config,  passwd = {DES}************************
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): binddn = cn=replication 
> manager,cn=config,  passwd = {DES}************************
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:11 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): binddn = cn=replication 
> manager,cn=config,  passwd = {DES}************************
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): Unable to acquire 
> replica: the replica is currently being updatedby another supplier. 
> Will try later
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): No linger to cancel on 
> the connection
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): Trying non-secure 
> slapi_ldap_init_ext
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): No linger to cancel on 
> the connection
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): Unable to acquire 
> replica: the replica is currently being updatedby another supplier. 
> Will try later
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: 
> ready_to_acquire_replica -> start_backoff
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): No linger to cancel on 
> the connection
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: 
> ready_to_acquire_replica -> start_backoff
> [03/Jun/2013:09:37:12 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa430002:1370270231:0:44
> [03/Jun/2013:09:37:12 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa440000:1370270232:0:44
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - ruv_update_ruv: 
> successfully committed csn 51acaa41000100010000
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): Trying non-secure 
> slapi_ldap_init_ext
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): binddn = cn=replication 
> manager,cn=config,  passwd = {DES}************************
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): Unable to acquire 
> replica: the replica is currently being updatedby another supplier. 
> Will try later
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: 
> ready_to_acquire_replica -> start_backoff
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: start_backoff -> 
> start_backoff
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: start_backoff -> 
> backoff
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> ruv_add_csn_inprogress: successfully inserted csn 51acaa41000200010000 
> into pending list
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): Replica was successfully 
> acquired.
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): Unable to acquire 
> replica: the replica is currently being updatedby another supplier. 
> Will try later
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: 
> ready_to_acquire_replica -> start_backoff
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: start_backoff -> 
> start_backoff
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - Purged state 
> information from entry 
> uid=tuser,ou=Contractors,ou=Groups,dc=company,dc=net up to CSN 
> 51a36fc1000100010000
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: 
> ready_to_acquire_replica -> sending_updates
> [03/Jun/2013:09:37:12 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): No linger to cancel on 
> the connection
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): binddn = cn=replication 
> manager,cn=config,  passwd = {DES}************************
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: start_backoff -> 
> backoff
> [03/Jun/2013:09:37:13 -0500] - csngen_adjust_time: gen state before 
> 51acaa440003:1370270232:0:44
> [03/Jun/2013:09:37:13 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa440003:1370270232:0:44
> [03/Jun/2013:09:37:13 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa450000:1370270233:0:44
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFile: found DB object 7f718513cba0 for database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:13 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389)): Consumer RUV:
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): No linger to cancel on 
> the connection
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 00000000
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 00000000
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:13 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389)): Supplier RUV:
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 51ac1e6c
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): Replica was successfully 
> acquired.
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): Unable to acquire 
> replica: the replica is currently being updatedby another supplier. 
> Will try later
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: 
> ready_to_acquire_replica -> sending_updates
> [03/Jun/2013:09:37:13 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000100010000 51acaa18
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): No changes to send
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - ruv_update_ruv: 
> successfully committed csn 51acaa41000200010000
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: start_backoff -> 
> backoff
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: 
> ready_to_acquire_replica -> start_backoff
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: start_backoff -> 
> start_backoff
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: backoff -> backoff
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: backoff -> backoff
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: start_backoff -> 
> backoff
> [03/Jun/2013:09:37:14 -0500] - csngen_adjust_time: gen state before 
> 51acaa450002:1370270233:0:44
> [03/Jun/2013:09:37:14 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa450002:1370270233:0:44
> [03/Jun/2013:09:37:14 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa460000:1370270234:0:44
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFile: found DB object 7f718513cba0 for database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:14 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389)): Consumer RUV:
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 00000000
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 00000000
> [03/Jun/2013:09:37:14 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389)): Supplier RUV:
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> ruv_add_csn_inprogress: successfully inserted csn 51acaa41000b00010000 
> into pending list
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - conn=62608 op=4 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:14 -0500] - csngen_adjust_time: gen state before 
> 51acaa460000:1370270234:0:44
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - conn=62608 op=4 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - conn=62608 op=4 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - conn=62608 op=4 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:14 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 51ac1e6c
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000200010000 51acaa1a
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): Successfully released 
> consumer
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: sending_updates -> 
> wait_for_changes
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: backoff -> backoff
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): Cancelling linger on the 
> connection
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: backoff -> backoff
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): Cancelling linger on the 
> connection
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): No changes to send
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - conn=62609 op=4 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: backoff -> backoff
> [03/Jun/2013:09:37:15 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa460000:1370270234:0:44
> [03/Jun/2013:09:37:15 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa470000:1370270235:0:44
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - Purged state 
> information from entry 
> uid=tuser,ou=Contractors,ou=Groups,dc=company,dc=net up to CSN 
> 51a36fc1000200010000
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): Successfully released 
> consumer
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:15 -0500] - csngen_adjust_time: gen state before 
> 51acaa470002:1370270235:0:44
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - conn=62607 op=4 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: sending_updates -> 
> wait_for_changes
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - conn=62609 op=4 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - conn=62609 op=4 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): Cancelling linger on the 
> connection
> [03/Jun/2013:09:37:15 -0500] - csngen_adjust_time: gen state before 
> 51acaa470002:1370270235:0:44
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - conn=62607 op=4 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:15 -0500] NSMMReplicationPlugin - conn=62607 op=4 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - conn=62607 op=4 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): Replica was successfully 
> acquired.
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - conn=62609 op=4 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): Replica was successfully 
> acquired.
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: backoff -> 
> sending_updates
> [03/Jun/2013:09:37:16 -0500] - csngen_adjust_time: gen state before 
> 51acaa470003:1370270235:0:44
> [03/Jun/2013:09:37:16 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa470003:1370270235:0:44
> [03/Jun/2013:09:37:16 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa480000:1370270236:0:44
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFile: found DB object 7f718513cba0 for database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:16 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-den1" (den-ds-01:389)): Consumer RUV:
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 00000000
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 00000000
> [03/Jun/2013:09:37:16 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-den1" (den-ds-01:389)): Supplier RUV:
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 51ac1e6c
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000200010000 51acaa1a
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): No changes to send
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: backoff -> backoff
> [03/Jun/2013:09:37:16 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): Cancelling linger on the 
> connection
> [03/Jun/2013:09:37:17 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa480000:1370270236:0:44
> [03/Jun/2013:09:37:17 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa490000:1370270237:0:44
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFileByReplicaName: found DB object 7f718513cba0 for 
> database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - ruv_update_ruv: 
> successfully committed csn 51acaa41000b00010000
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: backoff -> 
> sending_updates
> [03/Jun/2013:09:37:17 -0500] - csngen_adjust_time: gen state before 
> 51acaa490001:1370270237:0:44
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFile: found DB object 7f718513cba0 for database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:17 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389)): Consumer RUV:
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 00000000
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 00000000
> [03/Jun/2013:09:37:17 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389)): Supplier RUV:
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 51ac1e6c
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 51acaa1d
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): No changes to send
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - conn=62608 op=5 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: start_backoff -> 
> backoff
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): Replica was successfully 
> acquired.
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: backoff -> 
> sending_updates
> [03/Jun/2013:09:37:17 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): Successfully released 
> consumer
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: sending_updates -> 
> wait_for_changes
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: wait_for_changes 
> -> wait_for_changes
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62609 op=5 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:18 -0500] - csngen_adjust_time: gen state before 
> 51acaa490001:1370270237:0:44
> [03/Jun/2013:09:37:18 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa490001:1370270237:0:44
> [03/Jun/2013:09:37:18 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa4a0000:1370270238:0:44
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62608 op=5 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62608 op=5 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): Successfully released 
> consumer
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: sending_updates -> 
> wait_for_changes
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-hou4" (hou-ds-04:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): Replica was successfully 
> acquired.
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62607 op=5 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:18 -0500] - csngen_adjust_time: gen state before 
> 51acaa4a0000:1370270238:0:44
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFile: found DB object 7f718513cba0 for database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-kat1" (kat-ds-01:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: backoff -> 
> sending_updates
> [03/Jun/2013:09:37:18 -0500] - csngen_adjust_time: gen state before 
> 51acaa4a0000:1370270238:0:44
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62609 op=5 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62609 op=5 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62608 op=5 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): Cancelling linger on the 
> connection
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-hou3" (hou-ds-03:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:18 -0500] - csngen_adjust_time: gen state before 
> 51acaa4a0000:1370270238:0:44
> [03/Jun/2013:09:37:18 -0500] NSMMReplicationPlugin - conn=62607 op=5 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62606 id=3
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - conn=62607 op=5 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62606 id=3 for incremental update
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den1" (den-ds-01:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:19 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389)): Consumer RUV:
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 00000000
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - conn=62609 op=5 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:19 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa4a0000:1370270238:0:44
> [03/Jun/2013:09:37:19 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa4b0000:1370270239:0:44
> [03/Jun/2013:09:37:19 -0500] - csngen_adjust_time: gen state before 
> 51acaa4b0001:1370270239:0:44
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFile: found DB object 7f718513cba0 for database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - conn=62606 op=8 
> repl="dc=company,dc=net": Released replica
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - conn=62607 op=5 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 00000000
> [03/Jun/2013:09:37:19 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389)): Supplier RUV:
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): Replica was successfully 
> acquired.
> [03/Jun/2013:09:37:19 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-den2" (den-ds-02:389)): Consumer RUV:
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 00000000
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:19 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 00000000
> [03/Jun/2013:09:37:20 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-MM-kat2-den2" (den-ds-02:389)): Supplier RUV:
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 51ac1e6c
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 51ac1e6c
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 51acaa1d
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): No changes to send
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: backoff -> 
> sending_updates
> [03/Jun/2013:09:37:20 -0500] - csngen_adjust_time: gen state before 
> 51acaa4b0001:1370270239:0:44
> [03/Jun/2013:09:37:20 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa4b0001:1370270239:0:44
> [03/Jun/2013:09:37:20 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa4c0000:1370270240:0:44
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - changelog program 
> - _cl5GetDBFile: found DB object 7f718513cba0 for database 
> /var/lib/dirsrv/slapd-kat-ds-02/changelogdb/ff82ac02-c89d11e1-9593ba5c-bd1db041_51aba40d000000010000.db4
> [03/Jun/2013:09:37:20 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-CR-kat2-den3" (den-ds-03:389)): Consumer RUV:
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): Successfully released 
> consumer
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - conn=62608 op=6 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 51acaa1d
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): No changes to send
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 00000000
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 00000000
> [03/Jun/2013:09:37:20 -0500] - _cl5PositionCursorForReplay 
> (agmt="cn=sync-CR-kat2-den3" (den-ds-03:389)): Supplier RUV:
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replicageneration} 
> 51aba40d000000010000
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 2 
> ldap://kat-ds-02.kat.company.net:389 
> <http://kat-ds-02.kat.company.net:389>}
> [03/Jun/2013:09:37:20 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 4 
> ldap://den-ds-02.den.company.net:389 
> <http://den-ds-02.den.company.net:389>}
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 3 
> ldap://den-ds-01.den.company.net:389 
> <http://den-ds-01.den.company.net:389>}
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62606 op=9 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: sending_updates -> 
> wait_for_changes
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 20 
> ldap://hou-ds-03.company.net:389 <http://hou-ds-03.company.net:389>} 
> 51ac1e8f000000140000 51ac1e8f000000140000 51ac1e6c
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): {replica 1 
> ldap://kat-ds-01.kat.company.net:389 
> <http://kat-ds-01.kat.company.net:389>} 51aba45c000100010000 
> 51acaa41000b00010000 51acaa1d
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): No changes to send
> [03/Jun/2013:09:37:21 -0500] - csngen_adjust_time: gen state before 
> 51acaa4c0000:1370270240:0:44
> [03/Jun/2013:09:37:21 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa4c0000:1370270240:0:44
> [03/Jun/2013:09:37:21 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa4d0000:1370270241:0:44
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62608 op=6 
> repl="dc=company,dc=net": Acquired replica
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62609 op=6 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:21 -0500] - csngen_adjust_time: gen state before 
> 51acaa4d0000:1370270241:0:44
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62608 op=6 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=0 rc=0
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62606 op=9 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62608 id=6
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62606 op=9 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62608 id=6 for incremental update
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-kat3" (kat-ds-03:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:21 -0500] - csngen_adjust_time: gen state before 
> 51acaa4d0000:1370270241:0:44
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62609 op=6 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62608 id=6
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62609 op=6 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62608 id=6 for incremental update
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - conn=62609 op=6 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): Successfully released 
> consumer
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: sending_updates -> 
> wait_for_changes
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-MM-kat2-den2" (den-ds-02:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): Successfully released 
> consumer
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): Beginning linger on the 
> connection
> [03/Jun/2013:09:37:21 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: sending_updates -> 
> wait_for_changes
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: wait_for_changes 
> -> ready_to_acquire_replica
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - 
> agmt="cn=sync-CR-kat2-den3" (den-ds-03:389): State: 
> ready_to_acquire_replica -> wait_for_changes
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - conn=62607 op=6 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - conn=62606 op=9 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:22 -0500] - csngen_adjust_time: gen state before 
> 51acaa4d0000:1370270241:0:44
> [03/Jun/2013:09:37:22 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa4d0000:1370270241:0:44
> [03/Jun/2013:09:37:22 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa4e0000:1370270242:0:44
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - conn=62607 op=6 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62608 id=6
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - conn=62607 op=6 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62608 id=6 for incremental update
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - conn=62607 op=6 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:22 -0500] NSMMReplicationPlugin - conn=62608 op=7 
> repl="dc=company,dc=net": Released replica
> [03/Jun/2013:09:37:24 -0500] NSMMReplicationPlugin - conn=62609 op=7 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:24 -0500] - csngen_adjust_time: gen state before 
> 51acaa4e0000:1370270242:0:44
> [03/Jun/2013:09:37:24 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa4e0000:1370270242:0:44
> [03/Jun/2013:09:37:24 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa500000:1370270244:0:44
> [03/Jun/2013:09:37:24 -0500] NSMMReplicationPlugin - conn=62609 op=7 
> repl="dc=company,dc=net": Acquired replica
> [03/Jun/2013:09:37:24 -0500] NSMMReplicationPlugin - conn=62607 op=7 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:24 -0500] - csngen_adjust_time: gen state before 
> 51acaa500000:1370270244:0:44
> [03/Jun/2013:09:37:24 -0500] NSMMReplicationPlugin - conn=62607 op=7 
> repl="dc=company,dc=net": Replica in use locking_purl=conn=62609 id=7
> [03/Jun/2013:09:37:24 -0500] NSMMReplicationPlugin - conn=62607 op=7 
> replica="dc=company,dc=net": Unable to acquire replica: error: replica 
> busy locked by conn=62609 id=7 for incremental update
> [03/Jun/2013:09:37:24 -0500] NSMMReplicationPlugin - conn=62607 op=7 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=1 rc=0
> [03/Jun/2013:09:37:24 -0500] NSMMReplicationPlugin - conn=62609 op=7 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=0 rc=0
> [03/Jun/2013:09:37:25 -0500] NSMMReplicationPlugin - conn=62609 op=8 
> repl="dc=company,dc=net": Released replica
> [03/Jun/2013:09:37:26 -0500] NSMMReplicationPlugin - conn=62606 op=10 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:26 -0500] - csngen_adjust_time: gen state before 
> 51acaa500000:1370270244:0:44
> [03/Jun/2013:09:37:26 -0500] - _csngen_adjust_local_time: gen state 
> before 51acaa500000:1370270244:0:44
> [03/Jun/2013:09:37:26 -0500] - _csngen_adjust_local_time: gen state 
> after 51acaa520000:1370270246:0:44
> [03/Jun/2013:09:37:26 -0500] NSMMReplicationPlugin - conn=62606 op=10 
> repl="dc=company,dc=net": Acquired replica
> [03/Jun/2013:09:37:26 -0500] NSMMReplicationPlugin - conn=62606 op=10 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=0 rc=0
> [03/Jun/2013:09:37:26 -0500] NSMMReplicationPlugin - conn=62606 op=11 
> repl="dc=company,dc=net": Released replica
> [03/Jun/2013:09:37:26 -0500] NSMMReplicationPlugin - conn=62607 op=8 
> repl="dc=company,dc=net": Begin incremental protocol
> [03/Jun/2013:09:37:26 -0500] - csngen_adjust_time: gen state before 
> 51acaa520000:1370270246:0:44
> [03/Jun/2013:09:37:26 -0500] - csngen_adjust_time: gen state after 
> 51acaa520000:1370270246:0:44
> [03/Jun/2013:09:37:26 -0500] NSMMReplicationPlugin - conn=62607 op=8 
> repl="dc=company,dc=net": Acquired replica
> [03/Jun/2013:09:37:26 -0500] NSMMReplicationPlugin - conn=62607 op=8 
> repl="dc=company,dc=net": StartNSDS90ReplicationRequest: response=0 rc=0
> [03/Jun/2013:09:37:27 -0500] NSMMReplicationPlugin - conn=62607 op=9 
> repl="dc=company,dc=net": Released replica
>
>
>
> Thank you.
>
>
>
> --
> 389 users mailing list
> 389-users at lists.fedoraproject.org
> https://admin.fedoraproject.org/mailman/listinfo/389-users

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.fedoraproject.org/pipermail/389-users/attachments/20130603/c8eb9ffb/attachment.html>


More information about the 389-users mailing list