Bug 30044 - S4 Connector UDM to Samba4 account sync delayed for about 20 min in VMWare Image
S4 Connector UDM to Samba4 account sync delayed for about 20 min in VMWare Image
Status: CLOSED DUPLICATE of bug 30119
Product: UCS
Classification: Unclassified
Component: S4 Connector
UCS 3.1
Other Linux
: P5 normal (vote)
: UCS 3.1-1
Assigned To: Connector maintainers
Arvid Requate
:
Depends on:
Blocks:
  Show dependency treegraph
 
Reported: 2013-01-16 15:54 CET by Dirk Wiesenthal
Modified: 2013-03-25 19:57 CET (History)
2 users (show)

See Also:
What kind of report is it?: ---
What type of bug is this?: ---
Who will be affected by this bug?: ---
How will those affected feel about the bug?: ---
User Pain:
Enterprise Customer affected?:
School Customer affected?:
ISV affected?:
Waiting Support:
Flags outvoted (downgraded) after PO Review:
Ticket number:
Bug group (optional):
Max CVSS v3 score:


Attachments
connector-s4.log (53.04 KB, application/text)
2013-01-16 19:04 CET, Dirk Wiesenthal
Details
connector-s4-status.log (386 bytes, application/text)
2013-01-16 19:05 CET, Dirk Wiesenthal
Details

Note You need to log in before you can comment on or make changes to this bug.
Description Dirk Wiesenthal univentionstaff 2013-01-16 15:54:44 CET
Found while testing VMWare Image (Bug#29885). Joining a Windows machine (Windows said, it was successful) did not add a Windows Computer in UDM.

A user added in UDM was not found with univention-s4search:

root@master:~$ univention-s4search cn=user1
[...]
# returned 3 records
# 0 entries
# 3 referrals

root@master:~# univention-ldapsearch -LLL uid=user1
dn: uid=user1,cn=users,dc=vm-dirk,dc=test
[...]


The problem was solved after manually restarting univention-s4-connector. Maybe a timing problem?
Comment 1 Arvid Requate univentionstaff 2013-01-16 18:03:41 CET
/var/log/univention/connector-s4* would be required in this case.
One could check that manual modification of an S4-object (e.g. description of some samAccount) is replicated after about connector/s4/poll/sleep seconds. Additionally one could check if strace of the univention-s4-connector process shows any sign of activity.
Comment 2 Dirk Wiesenthal univentionstaff 2013-01-16 18:07:04 CET
I added a user in another VM on my local computer. Everything synced fine. I will try it once more with VMWareServer on leksvik.
Comment 3 Dirk Wiesenthal univentionstaff 2013-01-16 19:03:10 CET
I can reproduce this behaviour on leksvik-machines. I will attach both logs. These lines could be interesting:

sonnector-s4.log:

16.01.2013 19:24:06,445 LDAP        (PROCESS): sync to ucs:   [     container] [       add] CN=Machine,cn={6ac1786c-016f-11d2-945f-00c04fb984f9},cn=policies,cn=system,dc=vm-dirk,dc=test
16.01.2013 19:24:06,469 LDAP        (ERROR  ): Unknown Exception during sync_to_ucs
16.01.2013 19:24:06,477 LDAP        (ERROR  ): Traceback (most recent call last):
  File "/usr/lib/pymodules/python2.6/univention/s4connector/__init__.py", line 1293, in sync_to_ucs
    result = self.add_in_ucs(property_type, object, module, position)
  File "/usr/lib/pymodules/python2.6/univention/s4connector/__init__.py", line 1166, in add_in_ucs
    return ucs_object.create() and self.__modify_custom_attributes(property_type, object, ucs_object, module, position)
  File "/usr/lib/pymodules/python2.6/univention/admin/handlers/__init__.py", line 331, in create
    return self._create()
  File "/usr/lib/pymodules/python2.6/univention/admin/handlers/__init__.py", line 702, in _create
    self.lo.add(self.dn, al)
  File "/usr/lib/pymodules/python2.6/univention/admin/uldap.py", line 387, in add
    raise univention.admin.uexceptions.ldapError, _err2str(msg)
ldapError: No such object

16.01.2013 19:24:06,477 LDAP        (WARNING): sync to ucs was not successfull, save rejected
16.01.2013 19:24:06,477 LDAP        (WARNING): object was: CN=Machine,CN={6AC1786C-016F-11D2-945F-00C04FB984F9},CN=Policies,CN=System,DC=vm-dirk,DC=test


AND:

16.01.2013 19:24:31,924 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=dns-master,cn=users,dc=vm-dirk,dc=test
16.01.2013 19:46:55,474 MAIN        (------ ): DEBUG_INIT

Seems to be okay now. After 20 minutes! A second user was synced immediately (added after the first one was synced eventually).

s4-connector-status.log:

--------------------------------------
try to sync 3 changes from S4
done: <EOF>

After these 20 minutes:
--------------------------------------
try to sync 3 changes from S4
done: (1) (2) (3)
Changes from S4:  0 (0 saved rejected)
--------------------------------------
- sleep 5 seconds (4/10 until resync) -
Comment 4 Dirk Wiesenthal univentionstaff 2013-01-16 19:04:47 CET
Created attachment 4986 [details]
connector-s4.log
Comment 5 Dirk Wiesenthal univentionstaff 2013-01-16 19:05:14 CET
Created attachment 4987 [details]
connector-s4-status.log
Comment 6 Arvid Requate univentionstaff 2013-01-17 11:57:15 CET
The GPO-container related traceback (CN=Machine,cn={6ac1786c-016f-11d2-945f-00c04fb984f9},cn=policies,cn=system) ist a cosmetic issue (Bug 27293).

Reconfirmed details about the logs attached:
 * User jhuller was created at about 19:3x in UDM
 * Log entries indicate a non-manual restart of the S4 connector at 19:46:55,474
 * The user account is replicated ti Samba 4 at 19:46:55,683
 *
Comment 7 Arvid Requate univentionstaff 2013-01-17 11:59:43 CET
 * The issue seems to be specific for machines hosted on the specific virtualization server and did not occur on a VM hosted locally on a notebook
Comment 8 Stefan Gohmann univentionstaff 2013-01-18 10:36:14 CET
I can reproduce it if I change the IP address. For the current VMware image we have a workaround, see Bug #29885. This bug should be solved for UCS 3.1-1, maybe there is only a s4connector restart missing while changing the IP address in system.
Comment 9 Stefan Gohmann univentionstaff 2013-01-24 10:03:07 CET

*** This bug has been marked as a duplicate of bug 30119 ***
Comment 10 Arvid Requate univentionstaff 2013-03-18 14:48:22 CET
Verified:
 * Fix for Bug #30119 is in ucs3.1-1
Comment 11 Stefan Gohmann univentionstaff 2013-03-25 19:57:20 CET
UCS 3.1-1 has been released: 
 http://download.univention.de/doc/release-notes-3.1-1_en.pdf
 http://download.univention.de/doc/release-notes-3.1-1.pdf

If this error occurs again, please use "Clone This Bug".