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

Re: multi / standby master: incomplete replication after downtime (?)



On 18.08.2010 15:10, Oliver Liebel wrote:
the mmr config was tested many times and should work as expected,
but your clockskew below may be to great for mmr to work as intended

are your servers are physical/paravirt vms or full emulated vms?
if they are full emulated (eg vmware server), you will always run into
major clock skews.

check out / set some of your ntp settings, e.g.
- tinker panic 0
- server <....> minpoll <value> maxpoll <value>

yes, the time thing looks suspect to me also. I will try to get that better working; thanks for your hints.

But now, here's some log stuff; as announced ;) :

logfile excerpts from MASTER (hostname: ldapmaster) and STANDBY (hostname: ldapslave). I tried to make it as clearly arranged as possible by inserting self-explaining (hopefully ;)) tags into the logfiles. Here's what i did; and where:

- started both machines in a well working state (replication fine in every detail; freshly converted slapd.conf, freshly replicated). Both machines up. - insert tag "===_BEGIN_CHANGES_WHILE_BOTH_UP_===" into logfiles on both machines (script based)

 - MASTER: deleted user hcallahan (using jxplorer)
 - MASTER: added user mmouse (using ldapadd)
- MASTER: changed attribute telephone number user vcorleone to "0800-mafia" (using jxplorer)
 - MASTER: insert tag "===_END_CHANGES_WHILE_BOTH_UP_==="

- insert tag "===_END_CHANGES_WHILE_BOTH_UP_===" into logfiles on both machines

 - STANDBY: rcldap stop

 - insert tag "===_BEGIN_CHANGES_WHILE_STANDBY_DOWN_==="

 - MASTER: delete user jmcclane
 - MASTER: add user ggoofy
 - MASTER: change telephone number user ckent to "0800-superman"

 - insert tag "===_END_CHANGES_WHILE_STANDBY_DOWN_==="
 - insert tag "===_BEGIN_STANDBY_COMING_BACK_==="

 - STANDBY: rcldap start

 - insert tag "===_END_STANDBY_COMING_BACK_==="

The tags are in MASTER's and STANDBY's logfile, so one can compare what's going on at the same point in time.

The result on STANDBY at the end again is as i wrote before:
STANDBY:
 - every operation while it was up was successfully replicated
- the operations while it was down are partially replicated after coming up again:
 -- deletion user jmcclane: OK
 -- adding user ggoofy: obviously did not happen; not available on STANDBY
-- changing phone number ckent: did not happen; on STANDBY it's the same as before (means it differs now from the value it has on MASTER).

Here's the logfile of MASTER:
++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
===_BEGIN_CHANGES_WHILE_BOTH_UP_===
Aug 18 15:30:04 ldapmaster slapd[8017]: slap_queue_csn: queing 0x7f00f317b580 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapmaster slapd[8017]: slap_graduate_commit_csn: removing 0x7f00fb4ee230 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapmaster slapd[8017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapmaster slapd[8017]: do_syncrep2: rid=001 CSN too old, ignoring 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapmaster slapd[8017]: do_syncrep2: rid=002 cookie=rid=002,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapmaster slapd[8017]: do_syncrep2: rid=002 CSN too old, ignoring 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: slap_queue_csn: queing 0x7f00f397d060 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: slap_graduate_commit_csn: removing 0x7f00fb4ed9d0 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: do_syncrep2: rid=001 CSN too old, ignoring 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: do_syncrep2: rid=002 cookie=rid=002,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapmaster slapd[8017]: do_syncrep2: rid=002 CSN too old, ignoring 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: slap_queue_csn: queing 0x7f00f497e0f0 20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: slap_graduate_commit_csn: removing 0x7f00ec114bd0 20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: do_syncrep2: rid=001 CSN too old, ignoring 20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: do_syncrep2: rid=002 cookie=rid=002,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapmaster slapd[8017]: do_syncrep2: rid=002 CSN too old, ignoring 20100818133045.686887Z#000000#000#000000
===_END_CHANGES_WHILE_BOTH_UP_===
Aug 18 15:31:00 ldapmaster dhcpcd[2541]: eth0: renewing lease of 172.16.0.8
Aug 18 15:31:00 ldapmaster dhcpcd[2541]: eth0: leased 172.16.0.8 for 600 seconds Aug 18 15:31:00 ldapmaster dhcpcd[2541]: eth0: adding IP address 172.16.0.8/24 Aug 18 15:31:00 ldapmaster dhcpcd[2541]: eth0: adding default route via 172.16.0.1 metric 0 Aug 18 15:31:00 ldapmaster ifup: eth0 device: nVidia Corporation MCP51 Ethernet Controller (rev a3) Aug 18 15:31:20 ldapmaster dhclient: XMT: Solicit on eth0, interval 126630ms. Aug 18 15:31:39 ldapmaster slapd[8017]: do_syncrep2: rid=004 (-1) Can't contact LDAP server
Aug 18 15:31:39 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:31:39 ldapmaster slapd[8017]: do_syncrep2: rid=002 (-1) Can't contact LDAP server
Aug 18 15:31:39 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:31:44 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:44 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:31:44 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:44 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:31:49 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:49 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:31:49 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:49 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:31:54 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:54 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:31:54 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:54 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:31:59 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:59 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:31:59 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:31:59 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:04 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:04 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:04 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:04 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:09 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:09 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:09 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:09 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
===_BEGIN_CHANGES_WHILE_STANDBY_DOWN_===
Aug 18 15:32:14 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:14 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:14 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:14 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:19 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:19 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:19 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:19 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:24 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:24 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:24 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:24 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:26 ldapmaster slapd[8017]: slap_queue_csn: queing 0x7f00f397d580 20100818133226.335074Z#000000#000#000000 Aug 18 15:32:26 ldapmaster slapd[8017]: slap_graduate_commit_csn: removing 0x7f00fb4ed9d0 20100818133226.335074Z#000000#000#000000 Aug 18 15:32:26 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133226.335074Z#000000#000#000000 Aug 18 15:32:26 ldapmaster slapd[8017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133226.335074Z#000000#000#000000 Aug 18 15:32:26 ldapmaster slapd[8017]: do_syncrep2: rid=001 CSN too old, ignoring 20100818133226.335074Z#000000#000#000000 Aug 18 15:32:29 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:29 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:29 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:29 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:34 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:34 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:34 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:34 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:39 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:39 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:39 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:39 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:44 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:44 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:44 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:44 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:46 ldapmaster slapd[8017]: slap_queue_csn: queing 0x7f00f5180060 20100818133246.395672Z#000000#000#000000 Aug 18 15:32:46 ldapmaster slapd[8017]: slap_graduate_commit_csn: removing 0x7f00ec10dde0 20100818133246.395672Z#000000#000#000000 Aug 18 15:32:46 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133246.395672Z#000000#000#000000 Aug 18 15:32:46 ldapmaster slapd[8017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133246.395672Z#000000#000#000000 Aug 18 15:32:46 ldapmaster slapd[8017]: do_syncrep2: rid=001 CSN too old, ignoring 20100818133246.395672Z#000000#000#000000 Aug 18 15:32:49 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:49 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:49 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:49 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:54 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:54 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:32:54 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:54 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:59 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:59 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:32:59 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:32:59 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:04 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:04 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:04 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:04 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:05 ldapmaster slapd[8017]: slap_queue_csn: queing 0x7f00f317a0f0 20100818133305.849116Z#000000#000#000000 Aug 18 15:33:05 ldapmaster slapd[8017]: syncprov_sendresp: cookie=rid=001,csn=20100818133305.849116Z#000000#000#000000 Aug 18 15:33:05 ldapmaster slapd[8017]: slap_graduate_commit_csn: removing 0x7f00ec111bc0 20100818133305.849116Z#000000#000#000000 Aug 18 15:33:05 ldapmaster slapd[8017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133305.849116Z#000000#000#000000 Aug 18 15:33:05 ldapmaster slapd[8017]: do_syncrep2: rid=001 CSN too old, ignoring 20100818133305.849116Z#000000#000#000000 Aug 18 15:33:09 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:09 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:09 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:09 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:14 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:14 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:14 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:14 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:19 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:19 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:19 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:19 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:24 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:24 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:24 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:24 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
===_END_CHANGES_WHILE_STANDBY_DOWN_===
Aug 18 15:33:27 ldapmaster dhclient: XMT: Solicit on eth0, interval 124510ms. Aug 18 15:33:29 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:29 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:29 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:29 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:34 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:34 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:34 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:34 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:39 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:39 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:39 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:39 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:44 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:44 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:44 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:44 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:49 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:49 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:49 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:49 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
===_BEGIN_STANDBY_COMING_BACK_===
Aug 18 15:33:54 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:54 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:54 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:54 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:33:59 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=replicator,dc=local,dc=site" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:59 ldapmaster slapd[8017]: do_syncrepl: rid=002 rc -1 retrying
Aug 18 15:33:59 ldapmaster slapd[8017]: slap_client_connect: URI=ldap://ldapslave.local.site DN="cn=config" ldap_sasl_bind_s failed (-1)
Aug 18 15:33:59 ldapmaster slapd[8017]: do_syncrepl: rid=004 rc -1 retrying
Aug 18 15:34:03 ldapmaster slapd[8017]: srs csn 20100818133045.686887Z#000000#000#000000 Aug 18 15:34:03 ldapmaster slapd[8017]: log csn 20100818133004.663851Z#000000#000#000000
Aug 18 15:34:03 ldapmaster slapd[8017]: cmp -1, too old
Aug 18 15:34:03 ldapmaster slapd[8017]: log csn 20100818133045.686887Z#000000#000#000000
Aug 18 15:34:03 ldapmaster slapd[8017]: cmp 0, too old
Aug 18 15:34:03 ldapmaster slapd[8017]: log csn 20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapmaster slapd[8017]: log csn 20100818133305.849116Z#000000#000#000000 Aug 18 15:34:03 ldapmaster slapd[8017]: syncprov_playlog: cookie=rid=001,csn=20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapmaster slapd[8017]: Entry uid=vcorleone,ou=marketing,dc=local,dc=site changed by peer, ignored Aug 18 15:34:03 ldapmaster slapd[8017]: Entry uid=ckent,ou=verkauf,dc=local,dc=site changed by peer, ignored Aug 18 15:34:03 ldapmaster slapd[8017]: Entry uid=ggoofy,ou=verkauf,dc=local,dc=site changed by peer, ignored Aug 18 15:34:03 ldapmaster slapd[8017]: syncprov_search_response: cookie=rid=001,csn=20100818133305.849116Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0)
Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 cn=config
Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: do_syncrep2: rid=002 LDAP_RES_INTERMEDIATE - REFRESH_DELETE Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 cn=schema,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_add cn=schema,cn=config (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN cn={0}core,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 cn={0}core,cn=schema,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={0}core,cn=schema,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN cn={1}cosine,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 cn={1}cosine,cn=schema,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={1}cosine,cn=schema,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN cn={2}nis,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 cn={2}nis,cn=schema,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={2}nis,cn=schema,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN cn={3}inetorgperson,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 cn={3}inetorgperson,cn=schema,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={3}inetorgperson,cn=schema,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN olcDatabase={-1}frontend,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 olcDatabase={-1}frontend,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcDatabase={-1}frontend,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN olcOverlay={0}syncprov,olcDatabase={0}config,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 olcOverlay={0}syncprov,olcDatabase={0}config,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcOverlay={0}syncprov,olcDatabase={0}config,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN olcDatabase={1}hdb,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 olcDatabase={1}hdb,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcDatabase={1}hdb,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:04 ldapmaster slapd[8017]: dn_callback : entries have identical CSN olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config Aug 18 15:34:04 ldapmaster slapd[8017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config) Aug 18 15:34:04 ldapmaster slapd[8017]: do_syncrep2: rid=004 LDAP_RES_INTERMEDIATE - REFRESH_DELETE
Aug 18 15:34:04 ldapmaster slapd[8017]: do_syncrep2: rid=004 cookie=
===_END_STANDBY_COMING_BACK_===
++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++

And here's the logfile of STANDBY:
++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
===_BEGIN_CHANGES_WHILE_BOTH_UP_===
Aug 18 15:29:34 ldapslave sshd[10573]: Received disconnect from 172.16.0.8: 11: disconnected by user Aug 18 15:30:04 ldapslave slapd[7860]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: syncrepl_entry: rid=001 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_DELETE)
Aug 18 15:30:04 ldapslave slapd[7860]: syncrepl_entry: rid=001 be_search (0)
Aug 18 15:30:04 ldapslave slapd[7860]: syncrepl_entry: rid=001 uid=hcallahan,ou=verkauf,dc=local,dc=site Aug 18 15:30:04 ldapslave slapd[7860]: slap_queue_csn: queing 0x7fe5a2011990 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: slap_graduate_commit_csn: removing 0x7fe5a2239a70 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: syncprov_sendresp: cookie=rid=002,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: syncrepl_entry: rid=001 be_delete uid=hcallahan,ou=verkauf,dc=local,dc=site (0) Aug 18 15:30:04 ldapslave slapd[7860]: slap_queue_csn: queing 0x7fe5a2011990 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: syncprov_sendresp: cookie=rid=002,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: do_syncrep2: rid=002 cookie=rid=002,csn=20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: slap_graduate_commit_csn: removing 0x7fe5a2230230 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:04 ldapslave slapd[7860]: do_syncrep2: rid=002 CSN too old, ignoring 20100818133004.663851Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: syncrepl_entry: rid=001 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD)
Aug 18 15:30:25 ldapslave slapd[7860]: syncrepl_entry: rid=001 be_search (0)
Aug 18 15:30:25 ldapslave slapd[7860]: syncrepl_entry: rid=001 uid=mmouse,ou=verkauf,dc=local,dc=site Aug 18 15:30:25 ldapslave slapd[7860]: slap_queue_csn: queing 0x7fe5a2239920 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: slap_graduate_commit_csn: removing 0x7fe5a2237950 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: syncrepl_entry: rid=001 be_add uid=mmouse,ou=verkauf,dc=local,dc=site (0) Aug 18 15:30:25 ldapslave slapd[7860]: slap_queue_csn: queing 0x7fe5a2239920 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: syncprov_sendresp: cookie=rid=002,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: syncprov_sendresp: cookie=rid=002,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: do_syncrep2: rid=002 cookie=rid=002,csn=20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: slap_graduate_commit_csn: removing 0x7fe5a2237950 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:25 ldapslave slapd[7860]: do_syncrep2: rid=002 CSN too old, ignoring 20100818133025.570081Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: syncrepl_entry: rid=001 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_MODIFY)
Aug 18 15:30:45 ldapslave slapd[7860]: syncrepl_entry: rid=001 be_search (0)
Aug 18 15:30:45 ldapslave slapd[7860]: syncrepl_entry: rid=001 uid=vcorleone,ou=marketing,dc=local,dc=site Aug 18 15:30:45 ldapslave slapd[7860]: slap_queue_csn: queing 0x7fe5a2232c20 20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: slap_graduate_commit_csn: removing 0x7fe5a22397e0 20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: syncrepl_entry: rid=001 be_modify uid=vcorleone,ou=marketing,dc=local,dc=site (0) Aug 18 15:30:45 ldapslave slapd[7860]: syncprov_sendresp: cookie=rid=002,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: slap_queue_csn: queing 0x7fe5a2232c20 20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: syncprov_sendresp: cookie=rid=002,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: do_syncrep2: rid=002 cookie=rid=002,csn=20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: slap_graduate_commit_csn: removing 0x7fe5a2014610 20100818133045.686887Z#000000#000#000000 Aug 18 15:30:45 ldapslave slapd[7860]: do_syncrep2: rid=002 CSN too old, ignoring 20100818133045.686887Z#000000#000#000000
Aug 18 15:30:52 ldapslave dhcpcd[2588]: eth0: renewing lease of 172.16.0.9
Aug 18 15:30:52 ldapslave dhcpcd[2588]: eth0: leased 172.16.0.9 for 600 seconds Aug 18 15:30:52 ldapslave dhcpcd[2588]: eth0: adding IP address 172.16.0.9/24 Aug 18 15:30:52 ldapslave dhcpcd[2588]: eth0: adding default route via 172.16.0.1 metric 0 Aug 18 15:30:52 ldapslave ifup: eth0 device: nVidia Corporation MCP51 Ethernet Controller (rev a3) Aug 18 15:31:00 ldapslave sshd[10870]: Accepted publickey for root from 172.16.0.8 port 52210 ssh2
===_END_CHANGES_WHILE_BOTH_UP_===
Aug 18 15:31:00 ldapslave sshd[10870]: Received disconnect from 172.16.0.8: 11: disconnected by user Aug 18 15:31:39 ldapslave slapd[7860]: daemon: shutdown requested and initiated. Aug 18 15:31:39 ldapslave slapd[7860]: slapd shutdown: waiting for 0 operations/tasks to finish
Aug 18 15:31:39 ldapslave slapd[7860]: slapd stopped.
Aug 18 15:31:40 ldapslave dhclient: XMT: Solicit on eth0, interval 122570ms.
Aug 18 15:32:13 ldapslave sshd[10906]: Accepted publickey for root from 172.16.0.8 port 52223 ssh2
===_BEGIN_CHANGES_WHILE_STANDBY_DOWN_===
Aug 18 15:32:13 ldapslave sshd[10906]: Received disconnect from 172.16.0.8: 11: disconnected by user Aug 18 15:33:26 ldapslave sshd[10936]: Accepted publickey for root from 172.16.0.8 port 52255 ssh2
===_END_CHANGES_WHILE_STANDBY_DOWN_===
Aug 18 15:33:26 ldapslave sshd[10936]: Received disconnect from 172.16.0.8: 11: disconnected by user
Aug 18 15:33:42 ldapslave dhclient: XMT: Solicit on eth0, interval 110550ms.
Aug 18 15:33:54 ldapslave sshd[10964]: Accepted publickey for root from 172.16.0.8 port 52266 ssh2
===_BEGIN_STANDBY_COMING_BACK_===
Aug 18 15:33:54 ldapslave sshd[10964]: Received disconnect from 172.16.0.8: 11: disconnected by user Aug 18 15:34:03 ldapslave slapd[11015]: @(#) $OpenLDAP: slapd 2.4.21 (Jul 5 2010 13:35:22) $#012#011abuild@build16:/usr/src/packages/BUILD/openldap-2.4.21/servers/slapd Aug 18 15:34:03 ldapslave slapd[11017]: hdb_monitor_db_open: monitoring disabled; configure monitor database to enable
Aug 18 15:34:03 ldapslave slapd[11017]: slapd starting
Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=002 LDAP_RES_INTERMEDIATE - REFRESH_DELETE Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cace9be-3f11-102f-86fc-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0)
Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 cn=config
Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=001 LDAP_RES_INTERMEDIATE - SYNC_ID_SET Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: slap_queue_csn: queing 0x7f0c980030d0 20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cad9d96-3f11-102f-86fd-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1cace9be-3f11-102f-86fc-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cae0042-3f11-102f-86fe-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={0}core,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 cn={0}core,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={0}core,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0)
Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 cn=config
Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cae28ba-3f11-102f-86ff-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={1}cosine,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 cn={1}cosine,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={1}cosine,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cae4250-3f11-102f-8700-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={2}nis,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 cn={2}nis,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={2}nis,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cae5006-3f11-102f-8701-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={3}inetorgperson,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 cn={3}inetorgperson,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (cn={3}inetorgperson,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cae5b5a-3f11-102f-8702-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcDatabase={-1}frontend,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 olcDatabase={-1}frontend,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcDatabase={-1}frontend,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1cae6b04-3f11-102f-8704-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcOverlay={0}syncprov,olcDatabase={0}config,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 olcOverlay={0}syncprov,olcDatabase={0}config,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcOverlay={0}syncprov,olcDatabase={0}config,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1caf4e66-3f11-102f-8705-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcDatabase={1}hdb,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 olcDatabase={1}hdb,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcDatabase={1}hdb,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 inserted UUID 1caf57bc-3f11-102f-8706-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=004 entry unchanged, ignored (olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=004 LDAP_RES_INTERMEDIATE - REFRESH_DELETE
Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=004 cookie=
Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 913a0bf0-3f10-102f-92d5-4381bc469c2b Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: slap_graduate_commit_csn: removing 0x7f0c98016a70 20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_del_nonpresent: rid=001 be_delete uid=jmcclane,ou=security,dc=local,dc=site (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_add cn=schema,cn=config (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncprov_sendresp: cookie=rid=002,csn=20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=002 cookie=rid=002,csn=20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=002 CSN too old, ignoring 20100818133226.335074Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=001 LDAP_RES_INTERMEDIATE - REFRESH_DELETE Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=001 cookie=rid=001,csn=20100818133305.849116Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1cae0042-3f11-102f-86fe-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={0}core,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 cn={0}core,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (cn={0}core,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: slap_queue_csn: queing 0x7f0c980161b0 20100818133305.849116Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1cae28ba-3f11-102f-86ff-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={1}cosine,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 cn={1}cosine,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (cn={1}cosine,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1cae4250-3f11-102f-8700-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={2}nis,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 cn={2}nis,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (cn={2}nis,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1cae5006-3f11-102f-8701-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN cn={3}inetorgperson,cn=schema,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 cn={3}inetorgperson,cn=schema,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (cn={3}inetorgperson,cn=schema,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1cae5b5a-3f11-102f-8702-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcDatabase={-1}frontend,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 olcDatabase={-1}frontend,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (olcDatabase={-1}frontend,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1cae6b04-3f11-102f-8704-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcOverlay={0}syncprov,olcDatabase={0}config,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 olcOverlay={0}syncprov,olcDatabase={0}config,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (olcOverlay={0}syncprov,olcDatabase={0}config,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1caf4e66-3f11-102f-8705-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcDatabase={1}hdb,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 olcDatabase={1}hdb,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (olcDatabase={1}hdb,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 inserted UUID 1caf57bc-3f11-102f-8706-4bc6808babfc Aug 18 15:34:03 ldapslave slapd[11017]: dn_callback : entries have identical CSN olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config 20100818123730.848689Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 be_search (0) Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config Aug 18 15:34:03 ldapslave slapd[11017]: syncrepl_entry: rid=003 entry unchanged, ignored (olcOverlay={0}syncprov,olcDatabase={1}hdb,cn=config) Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=003 LDAP_RES_INTERMEDIATE - REFRESH_DELETE
Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=003 cookie=
Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=002 LDAP_RES_INTERMEDIATE - NEW_COOKIE Aug 18 15:34:03 ldapslave slapd[11017]: do_syncrep2: rid=002 NEW_COOKIE: rid=002,csn=20100818133305.849116Z#000000#000#000000 Aug 18 15:34:03 ldapslave slapd[11017]: slap_graduate_commit_csn: removing 0x7f0c980129b0 20100818133305.849116Z#000000#000#000000 Aug 18 15:34:48 ldapslave sshd[11032]: Accepted publickey for root from 172.16.0.8 port 52273 ssh2
===_END_STANDBY_COMING_BACK_===
+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++

Sorry for that lots of stuff... ;)
and thanks for your time !
best regards
--
elmar