Aaron Richton wrote:
Erm...
The last slave I switched back to using RefreshOnly which has picked up
all the changes.
Sorry, overlooked that. Are you patched for ITS#4417? (I use refreshOnly
and am still in a bad spot...)
I haven't patched for 4417, and while my slaves are picking up the
changes I do still see those delete
messages in the logs, just not always. The slaves have all been in
RefreshOnly mode since yesterday
afternoon, all changes seem to have propagated successfully in that
time. What I haven' managed to do
is search for the entry in the 13 seconds between a the del_nonpresent:
be_delete line and the be_add
line.
What's different from your case is that these are connections modifying
a single user, albeit 3 attributes, though
I did see more of the be_delete entries and more frequently yesterday
when I was re modifying
a large number of users (same 3 attributes) that hadn't propagated.
I'm reading your posts on -dev and only seeing stuff about 4365 which is
similar?
For Example
Master.log
Mar 21 16:03:45 master slapd[14964]: [ID 215403 local4.debug] conn=1797
op=1 BIND dn="uid=USER1,ou=People,dc=example,dc=com" method=128
Mar 21 16:03:45 master slapd[14964]: [ID 600343 local4.debug] conn=1797
op=1 BIND dn="uid=USER1,ou=People,dc=example,dc=com" mech=SIMPLE ssf=0
Mar 21 16:03:45 master slapd[14964]: [ID 588225 local4.debug] conn=1797
op=1 RESULT tag=97 err=0 text=
Mar 21 16:03:45 master slapd[14964]: [ID 249368 local4.debug] conn=1797
op=2 MOD dn="uid=USER1,ou=People,dc=example,dc=com"
Mar 21 16:03:45 master slapd[14964]: [ID 396994 local4.debug] conn=1797
op=2 MOD attr=sambaLMPassword sambaNTPassword userPassword
Slave1.log
Mar 21 16:03:52 slave1 slapd[22162]: [ID 151447 local4.debug]
syncrepl_del_nonpresent: be_delete uid=USER1,ou=People,dc=example,dc=com (0)
Mar 21 16:04:15 slave1 slapd[22162]: [ID 801593 local4.debug]
syncrepl_entry: LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD)
Mar 21 16:04:15 slave1 slapd[22162]: [ID 181434 local4.debug]
syncrepl_entry: be_search (0)
Mar 21 16:04:15 slave1 slapd[22162]: [ID 260518 local4.debug]
syncrepl_entry: uid=USER1,ou=People,dc=example,dc=com
Mar 21 16:04:15 slave1 slapd[22162]: [ID 181434 local4.debug]
syncrepl_entry: be_add (0)
Slave2.log
Mar 21 16:03:52 slave2 slapd[17389]: [ID 151447 local4.debug]
syncrepl_del_nonpresent: be_delete uid=USER1,ou=People,dc=example,dc=com (0)
Mar 21 16:04:15 slave2 slapd[17389]: [ID 260518 local4.debug]
syncrepl_entry: uid=USER1,ou=People,dc=example,dc=com
Slave3.log
Mar 21 16:03:58 slave3 slapd[25755]: [ID 260518 local4.debug]
syncrepl_entry: uid=USER1,ou=People,dc=example,dc=com
Mar 21 16:03:58 slave3 slapd[25755]: [ID 181434 local4.debug]
syncrepl_entry: be_modify (0)
Versus
Master.log
Mar 21 16:04:28 master slapd[14964]: [ID 215403 local4.debug] conn=1805
op=1 BIND dn="uid=USER2,ou=People,dc=example,dc=com" method=128
Mar 21 16:04:28 master slapd[14964]: [ID 600343 local4.debug] conn=1805
op=1 BIND dn="uid=USER2,ou=People,dc=example,dc=com" mech=SIMPLE ssf=0
Mar 21 16:04:28 master slapd[14964]: [ID 588225 local4.debug] conn=1805
op=1 RESULT tag=97 err=0 text=
Mar 21 16:04:28 master slapd[14964]: [ID 249368 local4.debug] conn=1805
op=2 MOD dn="uid=USER2,ou=People,dc=example,dc=com"
Mar 21 16:04:28 master slapd[14964]: [ID 396994 local4.debug] conn=1805
op=2 MOD attr=sambaLMPassword sambaNTPassword userPassword
Mar 21 16:04:28 master slapd[14964]: [ID 588225 local4.debug] conn=1805
op=2 RESULT tag=103 err=0 text=
Mar 21 16:04:28 master slapd[14964]: [ID 218904 local4.debug] conn=1805
op=3 UNBIND
Mar 21 16:04:28 master slapd[14964]: [ID 952275 local4.debug] conn=1805
fd=13 closed
Slave1
Mar 21 16:04:41 slave1 slapd[22162]: [ID 801593 local4.debug]
syncrepl_entry: LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD)
Mar 21 16:04:41 slave1 slapd[22162]: [ID 181434 local4.debug]
syncrepl_entry: be_search (0)
Mar 21 16:04:41 slave1 slapd[22162]: [ID 260518 local4.debug]
syncrepl_entry: uid=USER2,ou=People,dc=example,dc=com
Mar 21 16:04:41 slave1 slapd[22162]: [ID 181434 local4.debug]
syncrepl_entry: be_modify (0)
Slave2
Mar 21 16:04:41 slave2 slapd[17389]: [ID 801593 local4.debug]
syncrepl_entry: LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD)
Mar 21 16:04:41 slave2 slapd[17389]: [ID 181434 local4.debug]
syncrepl_entry: be_search (0)
Mar 21 16:04:41 slave2 slapd[17389]: [ID 260518 local4.debug]
syncrepl_entry: uid=USER2,ou=People,dc=example,dc=com
Mar 21 16:04:41 slave2 slapd[17389]: [ID 181434 local4.debug]
syncrepl_entry: be_modify (0)
Slave3
Mar 21 16:04:37 slave3 slapd[25755]: [ID 801593 local4.debug]
syncrepl_entry: LDAP_RES_SEARCH_ENTRY(LDAP_SYNC_ADD)
Mar 21 16:04:37 slave3 slapd[25755]: [ID 181434 local4.debug]
syncrepl_entry: be_search (0)
Mar 21 16:04:37 slave3 slapd[25755]: [ID 260518 local4.debug]
syncrepl_entry: uid=USER2,ou=People,dc=example,dc=com
Mar 21 16:04:37 slave3 slapd[25755]: [ID 181434 local4.debug]
syncrepl_entry: be_modify (0)
