[25/Apr/2012:14:31:57 -0400] NSMMReplicationPlugin - agmt_set_enabled_from_entry: agreement is now disabled (agmt="cn=to m3" (localhost:4003)) [25/Apr/2012:14:31:57 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): State: wait_for_changes -> wait_for_changes [25/Apr/2012:14:31:57 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): State: wait_for_changes -> wait_for_changes [25/Apr/2012:14:31:57 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): No linger to cancel on the connection [25/Apr/2012:14:31:58 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): Disconnected from the consumer [25/Apr/2012:14:31:58 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): repl5_inc_stop: protocol stopped after 0 seconds [25/Apr/2012:14:32:08 -0400] - _csngen_adjust_local_time: gen state before 4f9843e40001:1335378570:0:346 [25/Apr/2012:14:32:08 -0400] - _csngen_adjust_local_time: gen state after 4f9844820000:1335378728:0:346 [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - csnplInsert: CSN Pending list content: [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - 4f9844820000006f0000, not committed [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - ruv_add_csn_inprogress: successfully inserted csn 4f9844820000006f0000 into pending list [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - changelog program - _cl5GetDBFileByReplicaName: found DB object c49fd0 for database /var/lib/dirsrv/slapd-mmr1/changelogdb/bb6dd103-8a3d11e1-99bcf679-4e4ec8e0_4f983cbe0000006f0000.db4 [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - changelog program - _cl5GetDBFileByReplicaName: found DB object c49fd0 for database /var/lib/dirsrv/slapd-mmr1/changelogdb/bb6dd103-8a3d11e1-99bcf679-4e4ec8e0_4f983cbe0000006f0000.db4 [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - replica_update_ruv: csn 4f9844820000006f0000 [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - csnplCommit: CSN Pending list content: [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - 4f9844820000006f0000, not committed [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - ruv_update_ruv: successfully committed csn 4f9844820000006f0000 [25/Apr/2012:14:32:08 -0400] NSMMReplicationPlugin - ruv_update_ruv: rolled up to csn 4f9844820000006f0000 [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt_set_enabled_from_entry: agreement is now enabled (agmt="cn=to m3" (localhost:4003)) [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): No linger to cancel on the connection [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): Disconnected from the consumer [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): State: start -> ready_to_acquire_replica [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): Trying non-secure slapi_ldap_init_ext [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): binddn = uid=replica,cn=config, passwd = {DES}PpfjaR6Xa3N35MW/SmXAIQ== [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): No linger to cancel on the connection [25/Apr/2012:14:32:23 -0400] - _csngen_adjust_local_time: gen state before 4f9844830001:1335378729:0:346 [25/Apr/2012:14:32:23 -0400] - _csngen_adjust_local_time: gen state after 4f9844910000:1335378743:0:346 [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): Replica was successfully acquired. [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): State: ready_to_acquire_replica -> sending_updates [25/Apr/2012:14:32:23 -0400] - csngen_adjust_time: gen state before 4f9844910001:1335378743:0:346 [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - changelog program - _cl5GetDBFile: found DB object c49fd0 for database /var/lib/dirsrv/slapd-mmr1/changelogdb/bb6dd103-8a3d11e1-99bcf679-4e4ec8e0_4f983cbe0000006f0000.db4 [25/Apr/2012:14:32:23 -0400] - _cl5PositionCursorForReplay (agmt="cn=to m3" (localhost:4003)): Consumer RUV: [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): {replicageneration} 4f983cbe0000006f0000 [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): {replica 3333 ldap://localhost.localdomain:4003} [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): {replica 111 ldap://localhost.localdomain:4001} 4f983cf30000006f0000 4f983fa40000006f0000 00000000 [25/Apr/2012:14:32:23 -0400] - _cl5PositionCursorForReplay (agmt="cn=to m3" (localhost:4003)): Supplier RUV: [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): {replicageneration} 4f983cbe0000006f0000 [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): {replica 111 ldap://localhost.localdomain:4001} 4f983cf30000006f0000 4f9844820000006f0000 4f984328 [25/Apr/2012:14:32:23 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): {replica 3333 ldap://localhost.localdomain:4003} [25/Apr/2012:14:32:24 -0400] agmt="cn=to m3" (localhost:4003) - session start: anchorcsn=4f983fa40000006f0000 [25/Apr/2012:14:32:24 -0400] NSMMReplicationPlugin - changelog program - agmt="cn=to m3" (localhost:4003): CSN 4f983fa40000006f0000 found, position set for replay [25/Apr/2012:14:32:24 -0400] agmt="cn=to m3" (localhost:4003) - load=1 rec=1 csn=4f9844820000006f0000 [25/Apr/2012:14:32:24 -0400] - repl5_inc_result_threadmain starting [25/Apr/2012:14:32:24 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): replay_update: Sending add operation (dn="cn=mmmmmmmmmmmmm,dc=example,dc=com" csn=4f9844820000006f0000) [25/Apr/2012:14:32:24 -0400] - repl5_inc_result_threadmain: read result for message_id 0 [25/Apr/2012:14:32:24 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): replay_update: Consumer successfully sent operation with csn 4f9844820000006f0000 [25/Apr/2012:14:32:24 -0400] NSMMReplicationPlugin - conn=11 op=3 repl="dc=example,dc=com": Begin incremental protocol [25/Apr/2012:14:32:24 -0400] - repl5_inc_result_threadmain: read result for message_id 6 [25/Apr/2012:14:32:24 -0400] - repl5_inc_result_threadmain: result 1, 0, 0, 6, (null) [25/Apr/2012:14:32:24 -0400] - csngen_adjust_time: gen state before 4f9844910001:1335378743:0:346 [25/Apr/2012:14:32:24 -0400] - _csngen_adjust_local_time: gen state before 4f9844910001:1335378743:0:346 [25/Apr/2012:14:32:24 -0400] - _csngen_adjust_local_time: gen state after 4f9844920000:1335378744:0:346 [25/Apr/2012:14:32:24 -0400] agmt="cn=to m3" (localhost:4003) - clcache_load_buffer: rc=-30988 [25/Apr/2012:14:32:24 -0400] NSMMReplicationPlugin - agmt="cn=to m3" (localhost:4003): No more updates to send (cl5GetNextOperationToReplay)