Attachment 8257 Details for Bug 42840

reproduced connector-s4.log

connector-s4.log (text/x-log), 197.06 KB, created by Arvid Requate on 2016-11-29 19:55 CET

(hide)

Description:

Filename:

MIME Type:

Creator: Arvid Requate

Created: 2016-11-29 19:55 CET

Size: 197.06 KB

patch

obsolete

>23.11.2015 16:18:27,11 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:18:27,345 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:18:33,13 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:18:33,118 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:18:33,122 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:18:33,250 LDAP        (PROCESS): sync from ucs: [  container_dc] [       add] dc=ar41i1,DC=qa
>23.11.2015 16:18:33,264 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=dns,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,280 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=samba,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,296 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,305 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,313 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=computers,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,323 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=dc,cn=computers,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,341 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=Computers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,378 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,388 LDAP        (PROCESS): sync from ucs: [         group] [       add] CN=Domain Users,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,407 LDAP        (PROCESS): sync from ucs: [          user] [       add] CN=Administrator,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,461 LDAP        (PROCESS): sync from ucs: [         group] [       add] CN=Domain Admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,478 LDAP        (PROCESS): sync from ucs: [         group] [       add] CN=Domain Guests,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,497 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=DC Slave Hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,530 LDAP        (PROCESS): sync from ucs: [         group] [       add] CN=Print Operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,547 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=DC Backup Hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,595 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=memberserver,cn=computers,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,609 LDAP        (PROCESS): sync from ucs: [  container_dc] [       add] sambaDomainName=AR41I1,cn=samba,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,650 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=@,dc=8.200.10.in-addr.arpa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,695 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=master10,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,706 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,722 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=10,dc=8.200.10.in-addr.arpa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,739 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_domaincontroller_master._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,758 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=computers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,773 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=domain users,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,781 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=domain admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,788 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=domain guests,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,795 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=dc slave hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,806 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=print operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,813 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=dc backup hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,823 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,843 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kerberos._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,848 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,866 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kerberos._udp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,873 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,885 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kerberos-adm._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,900 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,917 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=Backup Join,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,938 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=Slave Join,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:33,963 LDAP        (PROCESS): sync from ucs: [          user] [       add] cn=join-backup,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,19 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=slave join,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,28 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc backup hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,38 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc slave hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,48 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=backup join,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,58 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=join-backup,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,79 LDAP        (PROCESS): sync from ucs: [          user] [       add] cn=join-slave,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,123 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc slave hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,134 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=slave join,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,141 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=join-slave,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,187 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,193 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,200 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain users,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,207 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain users,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,219 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc backup hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,229 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc backup hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,238 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc slave hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,246 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc slave hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,257 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=computers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,264 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=computers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,292 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=Virtual Machine Manager,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,306 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=Information,cn=virtual machine manager,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,317 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=CloudConnection,cn=virtual machine manager,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,329 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=CloudType,cn=virtual machine manager,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,347 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=ucs-sso,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,362 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,380 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=Builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,500 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=f5ba5f56-a5a2-400f-ae6b-9e65e2ab9158,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,509 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,520 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=_ldap._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,526 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,537 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=_ldap._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,542 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,557 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.dc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,563 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,575 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.8a3d52f7-889b-43d2-8130-f3d2538a8c60.domains,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,581 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,592 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kerberos._tcp.dc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,598 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,610 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kpasswd._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,615 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,627 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kpasswd._udp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,633 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,645 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.Default-First-Site-Name._sites,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,651 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,665 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.Default-First-Site-Name._sites.dc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,671 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,683 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kerberos._tcp.Default-First-Site-Name._sites,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,689 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,700 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_kerberos._tcp.Default-First-Site-Name._sites.dc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,706 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,718 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=gc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,726 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,738 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_gc._tcp,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,744 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,758 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.gc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,763 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,776 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_gc._tcp.Default-First-Site-Name._sites,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,782 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,797 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.Default-First-Site-Name._sites.gc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,804 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,817 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.pdc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,824 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,834 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,860 LDAP        (PROCESS): sync from ucs: [            dc] [    modify] CN=MASTER10,ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,873 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=System,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,879 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=Policies,cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,883 LDAP        (PROCESS): sync from ucs: [            ou] [       add] ou=Domain Controllers,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,901 LDAP        (PROCESS): sync from ucs: [            dc] [    modify] cn=master10,ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 16:18:34,905 LDAP        (PROCESS): initialize S4: last USN is 0, sync all
>23.11.2015 16:18:34,965 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,6 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,19 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=computers,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,32 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,66 LDAP        (PROCESS): sync to ucs:   [            ou] [    modify] ou=domain controllers,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,86 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,143 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=policies,cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,161 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=domain users,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,209 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=domain guests,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,244 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Domain Computers,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,324 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Domain Controllers,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,433 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=administrator,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,537 LDAP        (PROCESS): sync to ucs:   [          user] [       add] uid=Guest,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,586 LDAP        (WARNING): __set_values: The attributes for lastname have not been removed as it represents a mandatory attribute
>23.11.2015 16:18:35,839 LDAP        (WARNING): password_sync_ucs_s4_to_ucs: Failed to get Password-Hash from S4
>23.11.2015 16:18:35,865 LDAP        (PROCESS): sync to ucs:   [          user] [       add] uid=krbtgt,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:35,912 LDAP        (WARNING): __set_values: The attributes for lastname have not been removed as it represents a mandatory attribute
>23.11.2015 16:18:36,201 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Enterprise Read-Only Domain Controllers,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,285 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=domain admins,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,331 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Cert Publishers,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,427 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Schema Admins,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,524 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Enterprise Admins,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,626 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Group Policy Creator Owners,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,731 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Read-Only Domain Controllers,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,833 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=RAS and IAS Servers,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:36,929 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Allowed RODC Password Replication Group,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,25 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Denied RODC Password Replication Group,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,155 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Administrators,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,283 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Users,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,376 LDAP        (WARNING): group_members_sync_to_ucs: failed to identify object type of s4 member, ignore membership: CN=S-1-5-4,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa
>23.11.2015 16:18:37,377 LDAP        (WARNING): group_members_sync_to_ucs: failed to identify object type of s4 member, ignore membership: CN=S-1-5-11,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa
>23.11.2015 16:18:37,394 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Guests,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,499 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Account Operators,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,593 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Server Operators,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,680 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=printer-admins,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,722 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Backup Operators,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,817 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Replicator,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:37,911 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Pre-Windows 2000 Compatible Access,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,6 LDAP        (WARNING): group_members_sync_to_ucs: failed to identify object type of s4 member, ignore membership: CN=S-1-5-11,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa
>23.11.2015 16:18:38,15 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Remote Desktop Users,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,110 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Network Configuration Operators,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,211 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Incoming Forest Trust Builders,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,313 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Performance Monitor Users,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,412 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Performance Log Users,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,519 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Windows Authorization Access Group,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,619 LDAP        (WARNING): group_members_sync_to_ucs: failed to identify object type of s4 member, ignore membership: CN=S-1-5-9,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa
>23.11.2015 16:18:38,627 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Terminal Server License Servers,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,733 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Distributed COM Users,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,830 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=IIS_IUSRS,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:38,923 LDAP        (WARNING): group_members_sync_to_ucs: failed to identify object type of s4 member, ignore membership: CN=S-1-5-17,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa
>23.11.2015 16:18:38,932 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Cryptographic Operators,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,29 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Event Log Readers,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,131 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=Certificate Service DCOM Access,cn=builtin,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,234 LDAP        (PROCESS): sync to ucs:   [            dc] [    modify] cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,310 LDAP        (PROCESS): sync to ucs:   [         msGPO] [       add] CN={31B2F340-016D-11D2-945F-00C04FB984F9},cn=policies,cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,383 LDAP        (PROCESS): sync to ucs:   [     container] [       add] CN=User,cn={31b2f340-016d-11d2-945f-00c04fb984f9},cn=policies,cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,414 LDAP        (PROCESS): sync to ucs:   [     container] [       add] CN=Machine,cn={31b2f340-016d-11d2-945f-00c04fb984f9},cn=policies,cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,448 LDAP        (PROCESS): sync to ucs:   [         msGPO] [       add] CN={6AC1786C-016F-11D2-945F-00C04FB984F9},cn=policies,cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,504 LDAP        (PROCESS): sync to ucs:   [     container] [       add] CN=User,cn={6ac1786c-016f-11d2-945f-00c04fb984f9},cn=policies,cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,535 LDAP        (PROCESS): sync to ucs:   [     container] [       add] CN=Machine,cn={6ac1786c-016f-11d2-945f-00c04fb984f9},cn=policies,cn=system,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,571 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=DnsAdmins,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,670 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=DnsUpdateProxy,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,795 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zoneName=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,800 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,809 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=master10,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,816 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kerberos._tcp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,824 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kerberos._tcp.default-first-site-name._sites,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,831 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kerberos._udp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,838 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kpasswd._tcp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,845 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kpasswd._udp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,856 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,863 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp.default-first-site-name._sites,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,871 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_gc._tcp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,878 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_gc._tcp.default-first-site-name._sites,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,886 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=_msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,896 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=_ldap._tcp.Default-First-Site-Name._sites.DomainDnsZones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,912 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=_ldap._tcp.Default-First-Site-Name._sites.ForestDnsZones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,927 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=_ldap._tcp.DomainDnsZones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,943 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=_ldap._tcp.ForestDnsZones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,962 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=DomainDnsZones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,977 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=ForestDnsZones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,993 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zoneName=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:39,998 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=@._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,7 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kerberos._tcp.dc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,14 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kerberos._tcp.default-first-site-name._sites.dc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,22 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp.dc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,30 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp.default-first-site-name._sites.dc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,38 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp.default-first-site-name._sites.gc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,46 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp.gc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,56 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp.pdc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,63 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=gc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,71 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_ldap._tcp.8a3d52f7-889b-43d2-8130-f3d2538a8c60.domains._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,78 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=f5ba5f56-a5a2-400f-ae6b-9e65e2ab9158._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,85 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,102 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=samba,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,115 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=dc,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,130 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=computers,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,188 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=dc slave hosts,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,241 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,309 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=memberserver,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,325 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zoneName=8.200.10.in-addr.arpa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,330 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=8.200.10.in-addr.arpa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,336 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=10,zonename=8.200.10.in-addr.arpa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,343 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_domaincontroller_master._tcp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,350 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=_kerberos-adm._tcp,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,361 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=backup join,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,419 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=slave join,cn=groups,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,478 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=join-backup,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,593 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=join-slave,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,685 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=virtual machine manager,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,698 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=information,cn=virtual machine manager,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,710 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=cloudconnection,cn=virtual machine manager,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,723 LDAP        (PROCESS): sync to ucs:   [     container] [    modify] cn=cloudtype,cn=virtual machine manager,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,736 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=ucs-sso,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:18:40,743 LDAP        (PROCESS): sync to ucs:   [  container_dc] [    modify] dc=ar41i1,dc=qa
>23.11.2015 16:18:40,760 LDAP        (PROCESS): sync from ucs: [            ou] [    modify] ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,762 LDAP        (PROCESS): sync from ucs: [  container_dc] [    modify] DC=ar41i1,DC=qa
>23.11.2015 16:18:40,777 LDAP        (PROCESS): sync from ucs: [     container] [    modify] cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,780 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain users,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,793 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain guests,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,806 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=domain computers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,816 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=domain controllers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,828 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain controllers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,840 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=administrator,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,876 LDAP        (PROCESS): sync from ucs: [          user] [       add] cn=guest,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,910 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain guests,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,922 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=guest,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,942 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=guest,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:40,968 LDAP        (PROCESS): sync from ucs: [          user] [       add] cn=krbtgt,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,2 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain users,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,14 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=krbtgt,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,34 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=krbtgt,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,64 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=krbtgt,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,88 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=enterprise read-only domain controllers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,97 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,112 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=cert publishers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,126 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=schema admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,138 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=schema admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,151 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=enterprise admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,167 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=enterprise admins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,183 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=group policy creator owners,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,195 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=group policy creator owners,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,208 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=read-only domain controllers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,222 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=ras and ias servers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,234 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=allowed rodc password replication group,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,246 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=denied rodc password replication group,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,272 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=denied rodc password replication group,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,284 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=administrators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,294 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=administrators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,305 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=users,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,312 LDAP        (PROCESS): group_members_sync_from_ucs: cn=users,cn=builtin,dc=ar41i1,dc=qa is newly added. For this case don't remove the membership.
>23.11.2015 16:18:41,312 LDAP        (PROCESS): group_members_sync_from_ucs: cn=users,cn=builtin,dc=ar41i1,dc=qa is newly added. For this case don't remove the membership.
>23.11.2015 16:18:41,318 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=users,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,325 LDAP        (PROCESS): group_members_sync_from_ucs: cn=s-1-5-11,cn=foreignsecurityprincipals,dc=ar41i1,dc=qa was not found in group member con cache of cn=users,cn=builtin,dc=ar41i1,dc=qa, don't delete
>23.11.2015 16:18:41,325 LDAP        (PROCESS): group_members_sync_from_ucs: cn=s-1-5-4,cn=foreignsecurityprincipals,dc=ar41i1,dc=qa was not found in group member con cache of cn=users,cn=builtin,dc=ar41i1,dc=qa, don't delete
>23.11.2015 16:18:41,332 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=guests,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,345 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=guests,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,359 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=account operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,371 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=server operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,381 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=print operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,391 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=backup operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,403 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=replicator,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,415 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=pre-windows 2000 compatible access,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,420 LDAP        (PROCESS): group_members_sync_from_ucs: cn=pre-windows 2000 compatible access,cn=builtin,dc=ar41i1,dc=qa is newly added. For this case don't remove the membership.
>23.11.2015 16:18:41,429 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=remote desktop users,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,440 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=network configuration operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,455 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=incoming forest trust builders,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,467 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=performance monitor users,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,480 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=performance log users,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,492 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=windows authorization access group,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,497 LDAP        (PROCESS): group_members_sync_from_ucs: cn=windows authorization access group,cn=builtin,dc=ar41i1,dc=qa is newly added. For this case don't remove the membership.
>23.11.2015 16:18:41,505 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=terminal server license servers,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,517 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=distributed com users,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,529 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=iis_iusrs,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,534 LDAP        (PROCESS): group_members_sync_from_ucs: cn=iis_iusrs,cn=builtin,dc=ar41i1,dc=qa is newly added. For this case don't remove the membership.
>23.11.2015 16:18:41,542 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=cryptographic operators,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,557 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=event log readers,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,569 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=certificate service dcom access,cn=builtin,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,580 LDAP        (PROCESS): sync from ucs: [            dc] [    modify] cn=master10,ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,583 LDAP        (PROCESS): sync from ucs: [         msGPO] [       add] cn={31b2f340-016d-11d2-945f-00c04fb984f9},cn=policies,cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,586 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=user,cn={31b2f340-016d-11d2-945f-00c04fb984f9},cn=policies,cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,588 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=machine,cn={31b2f340-016d-11d2-945f-00c04fb984f9},cn=policies,cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,590 LDAP        (PROCESS): sync from ucs: [         msGPO] [       add] cn={6ac1786c-016f-11d2-945f-00c04fb984f9},cn=policies,cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,593 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=user,cn={6ac1786c-016f-11d2-945f-00c04fb984f9},cn=policies,cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,595 LDAP        (PROCESS): sync from ucs: [     container] [       add] cn=machine,cn={6ac1786c-016f-11d2-945f-00c04fb984f9},cn=policies,cn=system,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,601 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=dnsadmins,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,613 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=dnsupdateproxy,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,622 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.Default-First-Site-Name._sites.DomainDnsZones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,632 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.Default-First-Site-Name._sites.ForestDnsZones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,640 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.DomainDnsZones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,649 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=_ldap._tcp.ForestDnsZones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,661 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=DomainDnsZones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,670 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=ForestDnsZones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,679 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=computers,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,690 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc slave hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,706 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=dc backup hosts,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,719 LDAP        (PROCESS): sync from ucs: [            dc] [    modify] cn=master10,ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,723 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=backup join,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,733 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=join-backup,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,759 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=slave join,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,769 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=join-slave,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,790 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=join-backup,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,814 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=join-slave,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:18:41,832 LDAP        (PROCESS): sync from ucs: [  container_dc] [    modify] sambadomainname=ar41i1,cn=samba,DC=ar41i1,DC=qa
>23.11.2015 16:18:42,912 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=guest,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:42,983 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=krbtgt,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:18:51,319 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:18:51,365 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:18:52,373 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:18:52,466 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:18:57,650 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:18:57,690 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:18:57,694 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:19:02,959 LDAP        (PROCESS): sync to ucs:   [          user] [       add] uid=dns-master10,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:19:03,56 LDAP        (WARNING): __set_values: The attributes for lastname have not been removed as it represents a mandatory attribute
>23.11.2015 16:19:09,657 LDAP        (PROCESS): sync from ucs: [          user] [       add] cn=dns-master10,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:19:09,702 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=domain users,cn=groups,DC=ar41i1,DC=qa
>23.11.2015 16:19:09,722 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=dns-master10,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:19:09,748 LDAP        (PROCESS): sync from ucs: [          user] [    modify] cn=dns-master10,cn=users,DC=ar41i1,DC=qa
>23.11.2015 16:19:10,861 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=dns-master10,cn=users,dc=ar41i1,dc=qa
>23.11.2015 16:28:58,150 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=master10,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:28:58,170 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=gc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:28:58,181 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=@._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:28:58,188 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=domaindnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:28:58,198 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=forestdnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:28:58,208 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:29:04,264 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=master10,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:29:04,272 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=gc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:29:04,280 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=domaindnszones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:29:04,289 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=forestdnszones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:29:04,298 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:29:05,349 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=master10,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:29:05,360 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=gc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:29:05,373 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=domaindnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:29:05,386 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=forestdnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:29:05,397 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:29:05,411 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=@._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:42:17,209 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:42:17,269 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:42:17,274 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:44:47,470 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:44:47,512 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:44:52,549 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:44:52,604 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:44:57,637 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:44:57,665 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:02,693 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:02,793 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:07,833 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:07,873 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:12,899 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:12,938 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:17,969 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:18,13 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:23,45 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:23,71 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:28,101 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:28,126 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:33,153 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:33,207 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:38,237 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:38,272 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:43,298 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:43,320 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:48,349 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:48,417 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:53,463 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:53,503 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:45:58,535 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:45:58,594 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:46:03,621 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:46:03,801 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 16:46:08,865 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:46:08,911 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:46:08,975 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:46:09,296 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=master10,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:09,399 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=gc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:09,414 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=@._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:09,437 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=domaindnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:09,453 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=forestdnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:09,465 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:09,492 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=master10,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:46:09,507 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=gc,dc=_msdcs.ar41i1.qa,cn=microsoftdns,dc=forestdnszones,DC=ar41i1,DC=qa
>23.11.2015 16:46:09,514 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=domaindnszones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:46:09,524 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=forestdnszones,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:46:09,531 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 16:46:10,590 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=master10,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:10,610 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=gc._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:10,632 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=domaindnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:10,645 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=forestdnszones,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:10,658 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:46:10,669 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=@._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 16:47:42,979 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:47:43,31 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:47:43,112 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:50:28,364 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:50:28,408 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:50:28,413 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:50:38,585 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:50:38,624 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:50:38,630 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:50:44,78 MAIN        (------ ): DEBUG_INIT
>23.11.2015 16:50:44,119 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 16:50:44,125 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 16:51:19,747 LDAP        (PROCESS): sync from ucs: [            dc] [    modify] cn=master10,ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 16:51:20,990 LDAP        (PROCESS): sync to ucs:   [            dc] [    modify] cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 17:51:00,299 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:00,352 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:05,365 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:05,389 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:10,397 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:10,475 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:15,489 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:15,519 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:20,534 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:20,580 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:25,593 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:25,632 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:30,641 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:30,679 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:35,693 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:35,729 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:51:40,737 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:51:40,780 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 17:51:40,871 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 17:52:04,886 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:52:05,995 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 17:52:05,999 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 17:53:16,961 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:53:17,5 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 17:53:17,10 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 17:53:37,340 LDAP        (PROCESS): sync from ucs: [            dc] [    modify] cn=master10,ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 17:53:38,518 LDAP        (PROCESS): sync to ucs:   [            dc] [    modify] cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 17:55:00,490 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:55:00,527 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:55:05,537 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:55:05,582 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:55:10,597 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:55:10,636 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:55:15,649 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:55:15,679 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:55:20,689 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:55:20,721 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:55:25,729 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:55:25,767 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 17:55:30,785 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:55:30,849 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 17:55:30,859 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 17:56:33,666 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:56:33,720 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 17:56:33,727 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 17:57:44,716 MAIN        (------ ): DEBUG_INIT
>23.11.2015 17:57:44,816 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 17:57:44,821 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 17:58:05,159 LDAP        (PROCESS): sync from ucs: [            dc] [    modify] cn=master10,ou=domain controllers,DC=ar41i1,DC=qa
>23.11.2015 17:58:06,284 LDAP        (PROCESS): sync to ucs:   [            dc] [    modify] cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 20:37:43,728 MAIN        (------ ): DEBUG_INIT
>23.11.2015 20:37:43,790 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 20:37:48,801 MAIN        (------ ): DEBUG_INIT
>23.11.2015 20:37:48,865 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 20:37:48,870 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 21:15:37,698 MAIN        (------ ): DEBUG_INIT
>23.11.2015 21:15:37,753 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 21:15:37,759 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 21:17:59,235 MAIN        (------ ): DEBUG_INIT
>23.11.2015 21:17:59,250 LDAP        (ERROR  ): Failed to lookup S4 LDAP base, using UCR value.
>23.11.2015 21:19:01,643 MAIN        (------ ): DEBUG_INIT
>23.11.2015 21:19:01,692 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 21:19:01,754 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 21:22:09,97 LDAP        (PROCESS): sync to ucs:   [windowscomputer] [       add] cn=WIN7PRO230,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 21:22:09,462 LDAP        (PROCESS): sync to ucs:   [          user] [    modify] uid=administrator,cn=users,dc=ar41i1,dc=qa
>23.11.2015 21:22:15,618 LDAP        (PROCESS): sync from ucs: [windowscomputer] [       add] cn=win7pro230,cn=computers,DC=ar41i1,DC=qa
>23.11.2015 21:22:15,640 LDAP        (PROCESS): sync from ucs: [windowscomputer] [    modify] cn=win7pro230,cn=computers,DC=ar41i1,DC=qa
>23.11.2015 21:22:16,715 LDAP        (PROCESS): sync to ucs:   [windowscomputer] [    modify] cn=win7pro230,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 21:22:24,510 LDAP        (PROCESS): sync from ucs: [windowscomputer] [    modify] cn=win7pro230,cn=computers,DC=ar41i1,DC=qa
>23.11.2015 21:29:03,153 LDAP        (PROCESS): sync to ucs:   [windowscomputer] [    modify] cn=win7pro230,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 21:29:09,245 LDAP        (PROCESS): sync from ucs: [windowscomputer] [    modify] cn=win7pro230,cn=computers,DC=ar41i1,DC=qa
>23.11.2015 21:29:13,309 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=win7pro230,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:29,882 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=230,zonename=8.200.10.in-addr.arpa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:30,729 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:30,775 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=8.200.10.in-addr.arpa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:42,262 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=win7pro230,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 21:29:55,819 LDAP        (PROCESS): sync from ucs: [           dns] [       add] DC=230,dc=8.200.10.in-addr.arpa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 21:29:55,891 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=ar41i1.qa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 21:29:55,933 LDAP        (PROCESS): sync from ucs: [           dns] [    modify] dc=@,dc=8.200.10.in-addr.arpa,cn=microsoftdns,dc=domaindnszones,DC=ar41i1,DC=qa
>23.11.2015 21:29:56,979 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=win7pro230,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:57,5 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] relativedomainname=230,zonename=8.200.10.in-addr.arpa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:57,25 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:57,42 LDAP        (PROCESS): sync to ucs:   [           dns] [       add] relativeDomainName=@._msdcs,zonename=ar41i1.qa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:29:57,84 LDAP        (PROCESS): sync to ucs:   [           dns] [    modify] zonename=8.200.10.in-addr.arpa,cn=dns,dc=ar41i1,dc=qa
>23.11.2015 21:54:45,298 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=TestGroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 21:54:51,720 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 21:54:52,792 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=TestGroup2,cn=users,dc=ar41i1,dc=qa
>23.11.2015 21:54:59,32 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=testgroup2,cn=users,DC=ar41i1,DC=qa
>23.11.2015 21:55:00,82 LDAP        (PROCESS): sync to ucs:   [         group] [       add] cn=RestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 21:55:06,465 LDAP        (PROCESS): sync from ucs: [         group] [       add] cn=restgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 21:55:17,643 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 21:55:23,773 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 21:56:45,681 LDAP        (PROCESS): sync to ucs:   [            dc] [    modify] cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa
>23.11.2015 21:59:53,236 MAIN        (------ ): DEBUG_INIT
>23.11.2015 21:59:53,239 LDAP        (INFO   ): S4Cache: Execute SQL command: 'CREATE TABLE IF NOT EXISTS GUIDS (id INTEGER PRIMARY KEY, guid TEXT);'
>23.11.2015 21:59:53,240 LDAP        (INFO   ): S4Cache: Execute SQL command: 'CREATE TABLE IF NOT EXISTS ATTRIBUTES (id INTEGER PRIMARY KEY, attribute TEXT);'
>23.11.2015 21:59:53,240 LDAP        (INFO   ): S4Cache: Execute SQL command: 'CREATE TABLE IF NOT EXISTS DATA (id INTEGER PRIMARY KEY, guid_id INTEGER, attribute_id INTEGER, value TEXT);'
>23.11.2015 21:59:53,240 LDAP        (INFO   ): S4Cache: Execute SQL command: 'CREATE INDEX IF NOT EXISTS data_foreign_keys ON data(guid_id, attribute_id);'
>23.11.2015 21:59:53,240 LDAP        (INFO   ): S4Cache: Execute SQL command: 'CREATE INDEX IF NOT EXISTS attributes_attribute ON attributes(attribute);'
>23.11.2015 21:59:53,240 LDAP        (INFO   ): S4Cache: Execute SQL command: 'CREATE INDEX IF NOT EXISTS guids_guid ON guids(guid);'
>23.11.2015 21:59:53,240 LDAP        (INFO   ): LockingDB: Execute SQL command: 'CREATE TABLE IF NOT EXISTS S4_LOCK (id INTEGER PRIMARY KEY, guid TEXT);'
>23.11.2015 21:59:53,241 LDAP        (INFO   ): LockingDB: Execute SQL command: 'CREATE TABLE IF NOT EXISTS UCS_LOCK (id INTEGER PRIMARY KEY, uuid TEXT);'
>23.11.2015 21:59:53,241 LDAP        (INFO   ): LockingDB: Execute SQL command: 'CREATE INDEX IF NOT EXISTS s4_lock_guid ON s4_lock(guid);'
>23.11.2015 21:59:53,241 LDAP        (INFO   ): LockingDB: Execute SQL command: 'CREATE INDEX IF NOT EXISTS ucs_lock_uuid ON ucs_lock(uuid);'
>23.11.2015 21:59:53,253 LDAP        (INFO   ): init finished
>23.11.2015 21:59:53,253 LDAP        (INFO   ): __init__: The LDAP connection to S4 does not use SSL (switched off by UCR "connector/s4/ldap/ssl").
>23.11.2015 21:59:53,264 LDAP        (PROCESS): Building internal group membership cache
>23.11.2015 21:59:53,264 LDAP        (INFO   ): Search S4 with filter: objectClass=group
>23.11.2015 21:59:53,267 LDAP        (INFO   ): __init__: s4_groups: [(u'CN=Allowed RODC Password Replication Group,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Enterprise Read-only Domain Controllers,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Denied RODC Password Replication Group,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=Read-only Domain Controllers,CN=Groups,DC=ar41i1,DC=qa', u'CN=Group Policy Creator Owners,CN=Groups,DC=ar41i1,DC=qa', u'CN=Domain Admins,CN=Groups,DC=ar41i1,DC=qa', u'CN=Cert Publishers,CN=Groups,DC=ar41i1,DC=qa', u'CN=Enterprise Admins,CN=Groups,DC=ar41i1,DC=qa', u'CN=Schema Admins,CN=Groups,DC=ar41i1,DC=qa', u'CN=Domain Controllers,CN=Groups,DC=ar41i1,DC=qa', u'CN=krbtgt,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=Pre-Windows 2000 Compatible Access,CN=Builtin,DC=ar41i1,DC=qa', {'member': [u'CN=S-1-5-11,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa']}), (u'CN=Windows Authorization Access Group,CN=Builtin,DC=ar41i1,DC=qa', {'member': [u'CN=S-1-5-9,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa']}), (u'CN=Certificate Service DCOM Access,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Network Configuration Operators,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Terminal Server License Servers,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Incoming Forest Trust Builders,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Read-only Domain Controllers,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Group Policy Creator Owners,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=Administrator,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=Performance Monitor Users,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Cryptographic Operators,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Distributed COM Users,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Performance Log Users,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Remote Desktop Users,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=RAS and IAS Servers,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Account Operators,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Domain Controllers,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Event Log Readers,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Backup Operators,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Enterprise Admins,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=Administrator,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=Server Operators,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Domain Computers,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Print Operators,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=Administrators,CN=Builtin,DC=ar41i1,DC=qa', {'member': [u'CN=Domain Admins,CN=Groups,DC=ar41i1,DC=qa', u'CN=Enterprise Admins,CN=Groups,DC=ar41i1,DC=qa', u'CN=Administrator,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=Cert Publishers,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=DC Backup Hosts,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=Administrator,CN=Users,DC=ar41i1,DC=qa', u'CN=join-backup,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=DC Slave Hosts,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=DC Backup Hosts,CN=Groups,DC=ar41i1,DC=qa', u'CN=join-backup,CN=Users,DC=ar41i1,DC=qa', u'CN=join-slave,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=DnsUpdateProxy,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Domain Admins,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Domain Guests,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Schema Admins,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=Administrator,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=Domain Users,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=Administrator,cn=users,DC=ar41i1,DC=qa']}), (u'CN=Backup Join,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=Replicator,CN=Builtin,DC=ar41i1,DC=qa', {}), (u'CN=IIS_IUSRS,CN=Builtin,DC=ar41i1,DC=qa', {'member': [u'CN=S-1-5-17,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa']}), (u'CN=Slave Join,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=join-backup,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=Computers,CN=Groups,DC=ar41i1,DC=qa', {'member': [u'CN=DC Slave Hosts,CN=Groups,DC=ar41i1,DC=qa', u'CN=DC Backup Hosts,CN=Groups,DC=ar41i1,DC=qa']}), (u'CN=DnsAdmins,CN=Groups,DC=ar41i1,DC=qa', {}), (u'CN=RestGroup3,CN=Users,DC=ar41i1,DC=qa', {}), (u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa', {'member': [u'CN=RestGroup3,CN=Users,DC=ar41i1,DC=qa', u'CN=TestGroup2,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=TestGroup2,CN=Users,DC=ar41i1,DC=qa', {}), (u'CN=Guests,CN=Builtin,DC=ar41i1,DC=qa', {'member': [u'CN=Domain Guests,CN=Groups,DC=ar41i1,DC=qa', u'CN=Guest,CN=Users,DC=ar41i1,DC=qa']}), (u'CN=Users,CN=Builtin,DC=ar41i1,DC=qa', {'member': [u'CN=Domain Users,CN=Groups,DC=ar41i1,DC=qa', u'CN=S-1-5-4,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa', u'CN=S-1-5-11,CN=ForeignSecurityPrincipals,DC=ar41i1,DC=qa']})]
>23.11.2015 21:59:53,267 LDAP        (INFO   ): __init__: self.group_members_cache_con: {u'cn=users,cn=builtin,dc=ar41i1,dc=qa': [u'cn=domain users,cn=groups,dc=ar41i1,dc=qa', u'cn=s-1-5-4,cn=foreignsecurityprincipals,dc=ar41i1,dc=qa', u'cn=s-1-5-11,cn=foreignsecurityprincipals,dc=ar41i1,dc=qa'], u'cn=read-only domain controllers,cn=groups,dc=ar41i1,dc=qa': [], u'cn=domain computers,cn=groups,dc=ar41i1,dc=qa': [], u'cn=windows authorization access group,cn=builtin,dc=ar41i1,dc=qa': [u'cn=s-1-5-9,cn=foreignsecurityprincipals,dc=ar41i1,dc=qa'], u'cn=cert publishers,cn=groups,dc=ar41i1,dc=qa': [], u'cn=ras and ias servers,cn=groups,dc=ar41i1,dc=qa': [], u'cn=testgroup1,cn=users,dc=ar41i1,dc=qa': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'], u'cn=dnsadmins,cn=groups,dc=ar41i1,dc=qa': [], u'cn=network configuration operators,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=distributed com users,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=certificate service dcom access,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=backup operators,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=cryptographic operators,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=guests,cn=builtin,dc=ar41i1,dc=qa': [u'cn=domain guests,cn=groups,dc=ar41i1,dc=qa', u'cn=guest,cn=users,dc=ar41i1,dc=qa'], u'cn=server operators,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=slave join,cn=groups,dc=ar41i1,dc=qa': [u'cn=join-backup,cn=users,dc=ar41i1,dc=qa'], u'cn=group policy creator owners,cn=groups,dc=ar41i1,dc=qa': [u'cn=administrator,cn=users,dc=ar41i1,dc=qa'], u'cn=pre-windows 2000 compatible access,cn=builtin,dc=ar41i1,dc=qa': [u'cn=s-1-5-11,cn=foreignsecurityprincipals,dc=ar41i1,dc=qa'], u'cn=dc slave hosts,cn=groups,dc=ar41i1,dc=qa': [u'cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa', u'cn=join-backup,cn=users,dc=ar41i1,dc=qa', u'cn=join-slave,cn=users,dc=ar41i1,dc=qa'], u'cn=print operators,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=account operators,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=terminal server license servers,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=enterprise read-only domain controllers,cn=groups,dc=ar41i1,dc=qa': [], u'cn=allowed rodc password replication group,cn=groups,dc=ar41i1,dc=qa': [], u'cn=backup join,cn=groups,dc=ar41i1,dc=qa': [], u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa': [], u'cn=event log readers,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=domain admins,cn=groups,dc=ar41i1,dc=qa': [], u'cn=iis_iusrs,cn=builtin,dc=ar41i1,dc=qa': [u'cn=s-1-5-17,cn=foreignsecurityprincipals,dc=ar41i1,dc=qa'], u'cn=enterprise admins,cn=groups,dc=ar41i1,dc=qa': [u'cn=administrator,cn=users,dc=ar41i1,dc=qa'], u'cn=incoming forest trust builders,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=performance monitor users,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=domain guests,cn=groups,dc=ar41i1,dc=qa': [], u'cn=replicator,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa': [], u'cn=dnsupdateproxy,cn=groups,dc=ar41i1,dc=qa': [], u'cn=domain users,cn=groups,dc=ar41i1,dc=qa': [u'cn=administrator,cn=users,dc=ar41i1,dc=qa'], u'cn=computers,cn=groups,dc=ar41i1,dc=qa': [u'cn=dc slave hosts,cn=groups,dc=ar41i1,dc=qa', u'cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa'], u'cn=remote desktop users,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=administrators,cn=builtin,dc=ar41i1,dc=qa': [u'cn=domain admins,cn=groups,dc=ar41i1,dc=qa', u'cn=enterprise admins,cn=groups,dc=ar41i1,dc=qa', u'cn=administrator,cn=users,dc=ar41i1,dc=qa'], u'cn=schema admins,cn=groups,dc=ar41i1,dc=qa': [u'cn=administrator,cn=users,dc=ar41i1,dc=qa'], u'cn=domain controllers,cn=groups,dc=ar41i1,dc=qa': [], u'cn=performance log users,cn=builtin,dc=ar41i1,dc=qa': [], u'cn=denied rodc password replication group,cn=groups,dc=ar41i1,dc=qa': [u'cn=read-only domain controllers,cn=groups,dc=ar41i1,dc=qa', u'cn=group policy creator owners,cn=groups,dc=ar41i1,dc=qa', u'cn=domain admins,cn=groups,dc=ar41i1,dc=qa', u'cn=cert publishers,cn=groups,dc=ar41i1,dc=qa', u'cn=enterprise admins,cn=groups,dc=ar41i1,dc=qa', u'cn=schema admins,cn=groups,dc=ar41i1,dc=qa', u'cn=domain controllers,cn=groups,dc=ar41i1,dc=qa', u'cn=krbtgt,cn=users,dc=ar41i1,dc=qa'], u'cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa': [u'cn=administrator,cn=users,dc=ar41i1,dc=qa', u'cn=join-backup,cn=users,dc=ar41i1,dc=qa']}
>23.11.2015 21:59:53,269 LDAP        (INFO   ): __init__: self.group_members_cache_ucs: {'cn=schannel authentication,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=users,cn=builtin,dc=ar41i1,dc=qa': ['cn=domain users,cn=groups,dc=ar41i1,dc=qa'], 'cn=read-only domain controllers,cn=groups,dc=ar41i1,dc=qa': [], 'cn=enterprise domain controllers,cn=groups,dc=ar41i1,dc=qa': ['cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa', 'cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa'], 'cn=domain computers,cn=groups,dc=ar41i1,dc=qa': [], 'cn=windows authorization access group,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=terminal server user,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=certificate service dcom access,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=testgroup2,cn=users,dc=ar41i1,dc=qa': [], 'cn=cert publishers,cn=groups,dc=ar41i1,dc=qa': [], 'cn=domain controllers,cn=groups,dc=ar41i1,dc=qa': ['cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa'], 'cn=dnsupdateproxy,cn=groups,dc=ar41i1,dc=qa': [], 'cn=other organization,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=interactive,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=printer-admins,cn=groups,dc=ar41i1,dc=qa': [], 'cn=service,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=windows hosts,cn=groups,dc=ar41i1,dc=qa': ['cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa', 'cn=win7pro230,cn=computers,dc=ar41i1,dc=qa'], 'cn=network service,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=cryptographic operators,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=world authority,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=everyone,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=remote desktop users,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=account operators,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=null authority,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa': ['cn=master10,cn=dc,cn=computers,dc=ar41i1,dc=qa', 'uid=administrator,cn=users,dc=ar41i1,dc=qa', 'uid=join-backup,cn=users,dc=ar41i1,dc=qa'], 'cn=network configuration operators,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=guests,cn=builtin,dc=ar41i1,dc=qa': ['cn=domain guests,cn=groups,dc=ar41i1,dc=qa', 'uid=guest,cn=users,dc=ar41i1,dc=qa'], 'cn=server operators,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=digest authentication,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=terminal server license servers,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=slave join,cn=groups,dc=ar41i1,dc=qa': ['uid=join-backup,cn=users,dc=ar41i1,dc=qa', 'uid=join-slave,cn=users,dc=ar41i1,dc=qa'], 'cn=ntlm authentication,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=system,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=local service,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=group policy creator owners,cn=groups,dc=ar41i1,dc=qa': ['uid=administrator,cn=users,dc=ar41i1,dc=qa'], 'cn=pre-windows 2000 compatible access,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=owner rights,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=dialup,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=restricted,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=proxy,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=creator group,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=enterprise read-only domain controllers,cn=groups,dc=ar41i1,dc=qa': [], 'cn=allowed rodc password replication group,cn=groups,dc=ar41i1,dc=qa': [], 'cn=backup join,cn=groups,dc=ar41i1,dc=qa': ['uid=join-backup,cn=users,dc=ar41i1,dc=qa'], 'cn=restgroup3,cn=users,dc=ar41i1,dc=qa': [], 'cn=remote interactive logon,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=authenticated users,cn=builtin,dc=ar41i1,dc=qa': ['cn=dc slave hosts,cn=groups,dc=ar41i1,dc=qa', 'cn=windows hosts,cn=groups,dc=ar41i1,dc=qa'], 'cn=event log readers,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=iusr,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=nobody,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=domain admins,cn=groups,dc=ar41i1,dc=qa': ['uid=administrator,cn=users,dc=ar41i1,dc=qa'], 'cn=incoming forest trust builders,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=iis_iusrs,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=enterprise admins,cn=groups,dc=ar41i1,dc=qa': ['uid=administrator,cn=users,dc=ar41i1,dc=qa'], 'cn=dc slave hosts,cn=groups,dc=ar41i1,dc=qa': ['cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa', 'uid=join-backup,cn=users,dc=ar41i1,dc=qa', 'uid=join-slave,cn=users,dc=ar41i1,dc=qa'], 'cn=performance monitor users,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=distributed com users,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=domain guests,cn=groups,dc=ar41i1,dc=qa': ['uid=guest,cn=users,dc=ar41i1,dc=qa'], 'cn=ras and ias servers,cn=groups,dc=ar41i1,dc=qa': [], 'cn=performance log users,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=replicator,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=self,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=network,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=testgroup1,cn=users,dc=ar41i1,dc=qa': ['cn=restgroup3,cn=users,dc=ar41i1,dc=qa', 'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'], 'cn=computers,cn=groups,dc=ar41i1,dc=qa': ['cn=dc backup hosts,cn=groups,dc=ar41i1,dc=qa', 'cn=dc slave hosts,cn=groups,dc=ar41i1,dc=qa'], 'cn=backup operators,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=administrators,cn=builtin,dc=ar41i1,dc=qa': ['cn=domain admins,cn=groups,dc=ar41i1,dc=qa', 'cn=enterprise admins,cn=groups,dc=ar41i1,dc=qa', 'uid=administrator,cn=users,dc=ar41i1,dc=qa'], 'cn=creator owner,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=schema admins,cn=groups,dc=ar41i1,dc=qa': ['uid=administrator,cn=users,dc=ar41i1,dc=qa'], 'cn=dnsadmins,cn=groups,dc=ar41i1,dc=qa': [], 'cn=this organization,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=anonymous logon,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=batch,cn=builtin,dc=ar41i1,dc=qa': [], 'cn=denied rodc password replication group,cn=groups,dc=ar41i1,dc=qa': ['cn=read-only domain controllers,cn=groups,dc=ar41i1,dc=qa', 'cn=group policy creator owners,cn=groups,dc=ar41i1,dc=qa', 'cn=domain admins,cn=groups,dc=ar41i1,dc=qa', 'cn=cert publishers,cn=groups,dc=ar41i1,dc=qa', 'cn=enterprise admins,cn=groups,dc=ar41i1,dc=qa', 'cn=schema admins,cn=groups,dc=ar41i1,dc=qa', 'cn=domain controllers,cn=groups,dc=ar41i1,dc=qa', 'uid=krbtgt,cn=users,dc=ar41i1,dc=qa'], 'cn=domain users,cn=groups,dc=ar41i1,dc=qa': ['uid=administrator,cn=users,dc=ar41i1,dc=qa', 'uid=krbtgt,cn=users,dc=ar41i1,dc=qa', 'uid=dns-master10,cn=users,dc=ar41i1,dc=qa']}
>23.11.2015 21:59:53,269 LDAP        (PROCESS): Internal group membership cache was created
>23.11.2015 21:59:53,286 LDAP        (INFO   ): Override identify function for dns
>23.11.2015 21:59:53,291 LDAP        (INFO   ): Override identify function for container_dc
>23.11.2015 21:59:53,336 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:53,345 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:53,346 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:53,348 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:53,355 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:53,357 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:53,377 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:53,385 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:53,387 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:53,388 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:53,397 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:53,399 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:58,408 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:58,426 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:58,429 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 21:59:58,431 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:58,443 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 21:59:58,446 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:03,452 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:03,478 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:03,484 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:03,485 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:03,516 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:03,528 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:08,537 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:08,560 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:08,565 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:08,568 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:08,586 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:08,590 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:13,600 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:13,623 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:13,627 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:13,630 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:13,647 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:13,651 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:18,662 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:18,684 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:18,688 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:18,691 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:18,709 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:18,713 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:23,723 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:23,743 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:23,747 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:23,750 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:23,767 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:23,770 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:28,790 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:28,812 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:28,816 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:28,819 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:28,837 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:28,841 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:33,847 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:33,869 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:33,874 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:33,876 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:33,894 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:33,898 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:38,907 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:38,920 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:38,923 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3905)
>23.11.2015 22:00:38,924 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:38,935 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:38,935 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:38,937 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3905)
>23.11.2015 22:00:38,940 LDAP        (INFO   ): object_from_element: olddn: CN=RestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:38,941 LDAP        (INFO   ): _ignore_object: Do not ignore CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:38,941 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:38,941 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:38,942 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:38,942 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:38,942 LDAP        (INFO   ): samaccount_dn_mapping: not premapped (in first instance)
>23.11.2015 22:00:38,942 LDAP        (INFO   ): samaccount_dn_mapping: got an S4-Object
>23.11.2015 22:00:38,942 LDAP        (INFO   ): samaccount_dn_mapping: samaccountname not in mapping-table
>23.11.2015 22:00:38,942 LDAP        (INFO   ): samaccount_dn_mapping: samaccountname is:TestGroup3
>23.11.2015 22:00:38,943 LDAP        (INFO   ): samaccount_dn_mapping: newdn for key dn:
>23.11.2015 22:00:38,943 LDAP        (INFO   ): samaccount_dn_mapping: olddn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:38,943 LDAP        (INFO   ): samaccount_dn_mapping: newdn: cn=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:38,943 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:38,944 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:38,944 LDAP        (INFO   ): sid_to_ucs_mapping
>23.11.2015 22:00:38,944 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:38,946 LDAP        (INFO   ): get_ucs_object: object found: cn=restgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:38,946 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=TestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:38,946 LDAP        (INFO   ): sync_to_ucs: set position to cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:38,947 LDAP        (INFO   ): LockingDB: Execute SQL command: 'SELECT id FROM UCS_LOCK WHERE uuid=?;', '('349c438e-2670-1035-9929-193b4f095a89',)'
>23.11.2015 22:00:38,947 LDAP        (INFO   ): LockingDB: Return SQL result: '[]'
>23.11.2015 22:00:38,947 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:38,947 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:38,947 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT ATTRIBUTES.attribute,data.value from data 					inner join ATTRIBUTES ON data.attribute_id=attributes.id where guid_id = ?;', '('74',)'
>23.11.2015 22:00:38,948 LDAP        (INFO   ): S4Cache: Return SQL result: '[(u'distinguishedName', u'Q049UmVzdEdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n'), (u'cn', u'UmVzdEdyb3VwMw==\n'), (u'objectCategory', u'Q049R3JvdXAsQ049U2NoZW1hLENOPUNvbmZpZ3VyYXRpb24sREM9YXI0MWkxLERDPXFh\n'), (u'objectClass', u'dG9w\n'), (u'objectClass', u'Z3JvdXA=\n'), (u'objectGUID', u'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n'), (u'whenCreated', u'MjAxNTExMjMyMDU0NTQuMFo=\n'), (u'uSNCreated', u'MzkwMg==\n'), (u'uSNChanged', u'MzkwMg==\n'), (u'whenChanged', u'MjAxNTExMjMyMDU0NTQuMFo=\n'), (u'instanceType', u'NA==\n'), (u'name', u'UmVzdEdyb3VwMw==\n'), (u'objectSid', u'Uy0xLTUtMjEtMjY2MDg5NTI1Ni0xNjc4MDYyMTEzLTM4NTIwMjYzMjYtMTExNA==\n'), (u'groupType', u'LTIxNDc0ODM2NDY=\n'), (u'sAMAccountName', u'UmVzdEdyb3VwMw==\n'), (u'sAMAccountType', u'MjY4NDM1NDU2\n')]'
>23.11.2015 22:00:38,948 LDAP        (INFO   ): sync_to_ucs: old_s4_object: {'distinguishedName': ['CN=RestGroup3,CN=Users,DC=ar41i1,DC=qa'], 'groupType': ['-2147483646'], 'cn': ['RestGroup3'], 'objectCategory': ['CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': ['top', 'group'], 'objectGUID': ['\xc2\x9aR \xc3\xa9\xc2\xb0\xc3\x95>G\xc2\x94=)\xc3\xa2\xc3\xa6&\xc3\x9bU'], 'sAMAccountName': ['RestGroup3'], 'whenChanged': ['20151123205454.0Z'], 'sAMAccountType': ['268435456'], 'objectSid': ['S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': ['20151123205454.0Z'], 'uSNCreated': ['3902'], 'uSNChanged': ['3902'], 'instanceType': ['4'], 'name': ['RestGroup3']}
>23.11.2015 22:00:38,948 LDAP        (INFO   ): sync_to_ucs: new_s4_object: {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa'], 'sAMAccountName': [u'TestGroup3'], 'name': [u'TestGroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'whenChanged': [u'20151123210035.0Z'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3906'], 'instanceType': [u'4'], 'cn': [u'TestGroup3']}
>23.11.2015 22:00:38,948 LDAP        (INFO   ): The following attributes have been changed: ['distinguishedName', 'sAMAccountName', 'name', 'memberOf', 'whenChanged', 'uSNChanged', 'cn']
>23.11.2015 22:00:38,949 LDAP        (INFO   ): __set_values: object: {'dn': u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa', 'olddn': u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', 'changed_attributes': ['distinguishedName', 'sAMAccountName', 'name', 'memberOf', 'whenChanged', 'uSNChanged', 'cn'], 'modtype': 'modify', 'attributes': {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa'], 'cn': [u'TestGroup3'], 'name': [u'TestGroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'sambaSID': u'1114', 'whenChanged': [u'20151123210035.0Z'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3906'], 'univentionGroupType': [u'-2147483646'], 'instanceType': [u'4'], 'sAMAccountName': [u'TestGroup3']}}
>23.11.2015 22:00:38,950 LDAP        (INFO   ): __set_values: Skip: groupType
>23.11.2015 22:00:38,950 LDAP        (INFO   ): __set_values: Skip: objectSid
>23.11.2015 22:00:38,950 LDAP        (INFO   ): __set_values: Skip: mail
>23.11.2015 22:00:38,950 LDAP        (INFO   ): __set_values: Set: sAMAccountName
>23.11.2015 22:00:38,950 LDAP        (INFO   ): __set_values: set attribute, ucs_key: name - value: [u'TestGroup3']
>23.11.2015 22:00:38,955 LDAP        (INFO   ): __set_values: module groups/group has no custom attributes
>23.11.2015 22:00:38,955 LDAP        (INFO   ): set key in ucs-object: name
>23.11.2015 22:00:38,956 LDAP        (INFO   ): __set_values: Skip: description
>23.11.2015 22:00:39,16 LDAP        (INFO   ): __modify_custom_attributes: no custom attributes found
>23.11.2015 22:00:39,39 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:39,39 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:39,39 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:39,40 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:39,40 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:39,40 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:39,40 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT ATTRIBUTES.attribute,data.value from data 					inner join ATTRIBUTES ON data.attribute_id=attributes.id where guid_id = ?;', '('74',)'
>23.11.2015 22:00:39,40 LDAP        (INFO   ): S4Cache: Return SQL result: '[(u'distinguishedName', u'Q049UmVzdEdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n'), (u'cn', u'UmVzdEdyb3VwMw==\n'), (u'objectCategory', u'Q049R3JvdXAsQ049U2NoZW1hLENOPUNvbmZpZ3VyYXRpb24sREM9YXI0MWkxLERDPXFh\n'), (u'objectClass', u'dG9w\n'), (u'objectClass', u'Z3JvdXA=\n'), (u'objectGUID', u'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n'), (u'whenCreated', u'MjAxNTExMjMyMDU0NTQuMFo=\n'), (u'uSNCreated', u'MzkwMg==\n'), (u'uSNChanged', u'MzkwMg==\n'), (u'whenChanged', u'MjAxNTExMjMyMDU0NTQuMFo=\n'), (u'instanceType', u'NA==\n'), (u'name', u'UmVzdEdyb3VwMw==\n'), (u'objectSid', u'Uy0xLTUtMjEtMjY2MDg5NTI1Ni0xNjc4MDYyMTEzLTM4NTIwMjYzMjYtMTExNA==\n'), (u'groupType', u'LTIxNDc0ODM2NDY=\n'), (u'sAMAccountName', u'UmVzdEdyb3VwMw==\n'), (u'sAMAccountType', u'MjY4NDM1NDU2\n')]'
>23.11.2015 22:00:39,41 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('memberOf',)'
>23.11.2015 22:00:39,41 LDAP        (INFO   ): S4Cache: Return SQL result: '[(36,)]'
>23.11.2015 22:00:39,41 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('distinguishedName',)'
>23.11.2015 22:00:39,41 LDAP        (INFO   ): S4Cache: Return SQL result: '[(1,)]'
>23.11.2015 22:00:39,41 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('cn',)'
>23.11.2015 22:00:39,42 LDAP        (INFO   ): S4Cache: Return SQL result: '[(3,)]'
>23.11.2015 22:00:39,42 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('name',)'
>23.11.2015 22:00:39,42 LDAP        (INFO   ): S4Cache: Return SQL result: '[(15,)]'
>23.11.2015 22:00:39,42 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('objectGUID',)'
>23.11.2015 22:00:39,42 LDAP        (INFO   ): S4Cache: Return SQL result: '[(7,)]'
>23.11.2015 22:00:39,42 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('whenChanged',)'
>23.11.2015 22:00:39,42 LDAP        (INFO   ): S4Cache: Return SQL result: '[(13,)]'
>23.11.2015 22:00:39,43 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('uSNChanged',)'
>23.11.2015 22:00:39,43 LDAP        (INFO   ): S4Cache: Return SQL result: '[(12,)]'
>23.11.2015 22:00:39,43 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('sAMAccountName',)'
>23.11.2015 22:00:39,43 LDAP        (INFO   ): S4Cache: Return SQL result: '[(37,)]'
>23.11.2015 22:00:39,43 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '36', 'Q049VGVzdEdyb3VwMSxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n')'
>23.11.2015 22:00:39,43 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('1', '74', 'Q049UmVzdEdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n')'
>23.11.2015 22:00:39,44 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '1', 'Q049VGVzdEdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n')'
>23.11.2015 22:00:39,44 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('3', '74', 'UmVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:39,44 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '3', 'VGVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:39,44 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('15', '74', 'UmVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:39,44 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '15', 'VGVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:39,44 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('7', '74', 'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n')'
>23.11.2015 22:00:39,45 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '7', 'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n')'
>23.11.2015 22:00:39,45 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('13', '74', 'MjAxNTExMjMyMDU0NTQuMFo=\n')'
>23.11.2015 22:00:39,45 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '13', 'MjAxNTExMjMyMTAwMzUuMFo=\n')'
>23.11.2015 22:00:39,45 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('12', '74', 'MzkwMg==\n')'
>23.11.2015 22:00:39,45 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '12', 'MzkwNg==\n')'
>23.11.2015 22:00:39,45 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('37', '74', 'UmVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:39,45 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '37', 'VGVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:39,87 LDAP        (INFO   ): Call post_ucs_modify_functions: <function group_members_sync_to_ucs at 0x28067d0>
>23.11.2015 22:00:39,87 LDAP        (INFO   ): group_members_sync_to_ucs: object: {'dn': u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa', 'olddn': u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', 'changed_attributes': ['distinguishedName', 'sAMAccountName', 'name', 'memberOf', 'whenChanged', 'uSNChanged', 'cn'], 'modtype': 'modify', 'attributes': {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa'], 'cn': [u'TestGroup3'], 'name': [u'TestGroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'sambaSID': u'1114', 'whenChanged': [u'20151123210035.0Z'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3906'], 'univentionGroupType': [u'-2147483646'], 'instanceType': [u'4'], 'sAMAccountName': [u'TestGroup3']}}
>23.11.2015 22:00:39,87 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:39,87 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:39,88 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:39,88 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:39,89 LDAP        (INFO   ): get_object: got object: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:39,89 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:39,89 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:39,89 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:39,90 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object not found
>23.11.2015 22:00:39,90 LDAP        (INFO   ): samaccount_dn_mapping: got an UCS-Object
>23.11.2015 22:00:39,90 LDAP        (INFO   ): samaccount_dn_mapping: search in s4 for (&(objectclass=group)(samaccountname=TestGroup3))
>23.11.2015 22:00:39,90 LDAP        (INFO   ): samaccount_dn_mapping: newdn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:39,91 LDAP        (INFO   ): samaccount_dn_mapping: newdn for key olddn:
>23.11.2015 22:00:39,91 LDAP        (INFO   ): samaccount_dn_mapping: olddn: cn=restgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:39,91 LDAP        (INFO   ): samaccount_dn_mapping: newdn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:39,91 LDAP        (INFO   ): group_members_sync_to_ucs: s4_object (mapped): {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'olddn': u'CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa', 'changed_attributes': ['distinguishedName', 'sAMAccountName', 'name', 'memberOf', 'whenChanged', 'uSNChanged', 'cn'], 'modtype': 'modify', 'attributes': {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa'], 'cn': [u'TestGroup3'], 'name': [u'TestGroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'sambaSID': u'1114', 'whenChanged': [u'20151123210035.0Z'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3906'], 'univentionGroupType': [u'-2147483646'], 'instanceType': [u'4'], 'sAMAccountName': [u'TestGroup3']}}
>23.11.2015 22:00:39,91 LDAP        (INFO   ): group_members_sync_to_ucs: ucs_members: set([])
>23.11.2015 22:00:39,92 LDAP        (INFO   ): get_object: got object: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:39,92 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:39,93 LDAP        (INFO   ): group_members_sync_to_ucs: s4_members []
>23.11.2015 22:00:39,93 LDAP        (INFO   ): group_members_sync_to_ucs: Reset con cache
>23.11.2015 22:00:39,93 LDAP        (INFO   ): group_members_sync_to_ucs: dn_mapping_ucs_member_to_s4={}
>23.11.2015 22:00:39,93 LDAP        (INFO   ): group_members_sync_to_ucs: ucs_members: set([])
>23.11.2015 22:00:39,93 LDAP        (INFO   ): group_members_sync_to_ucs: ucs_members_from_s4: {'unknown': [], 'group': [], 'user': []}
>23.11.2015 22:00:39,93 LDAP        (INFO   ): group_members_sync_to_ucs: members to add: {'unknown': [], 'group': [], 'user': []}
>23.11.2015 22:00:39,93 LDAP        (INFO   ): group_members_sync_to_ucs: members to del: {'group': [], 'user': []}
>23.11.2015 22:00:39,93 LDAP        (INFO   ): Call post_ucs_modify_functions: <function group_members_sync_to_ucs at 0x28067d0> (done)
>23.11.2015 22:00:39,93 LDAP        (INFO   ): Call post_ucs_modify_functions: <function object_memberships_sync_to_ucs at 0x2806848>
>23.11.2015 22:00:39,94 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:39,94 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:39,94 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:39,94 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:39,95 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:39,95 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:39,95 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object not found
>23.11.2015 22:00:39,95 LDAP        (INFO   ): samaccount_dn_mapping: got an S4-Object
>23.11.2015 22:00:39,96 LDAP        (INFO   ): samaccount_dn_mapping: samaccountname not in mapping-table
>23.11.2015 22:00:39,96 LDAP        (INFO   ): samaccount_dn_mapping: samaccountname is:TestGroup3
>23.11.2015 22:00:39,96 LDAP        (INFO   ): samaccount_dn_mapping: newdn is ucsdn
>23.11.2015 22:00:39,96 LDAP        (INFO   ): samaccount_dn_mapping: newdn for key olddn:
>23.11.2015 22:00:39,96 LDAP        (INFO   ): samaccount_dn_mapping: olddn: cn=restgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:39,96 LDAP        (INFO   ): samaccount_dn_mapping: newdn: cn=TestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:39,97 LDAP        (INFO   ): sid_to_ucs_mapping
>23.11.2015 22:00:39,97 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:39,97 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:39,98 LDAP        (INFO   ): _ignore_object: Do not ignore CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:39,98 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:39,98 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:39,99 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:39,99 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:39,99 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:39,99 LDAP        (INFO   ): sid_to_ucs_mapping
>23.11.2015 22:00:39,100 LDAP        (INFO   ): object_memberships_sync_to_ucs: sync_object: {'sambaGroupType': ['2'], 'cn': ['TestGroup1'], 'objectClass': ['top', 'univentionGroup', 'posixGroup', 'univentionObject', 'sambaGroupMapping'], 'univentionObjectType': ['groups/group'], 'sambaSID': ['S-1-5-21-2660895256-1678062113-3852026326-1112'], 'gidNumber': ['5073'], 'uniqueMember': ['cn=restgroup3,cn=users,dc=ar41i1,dc=qa', 'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'], 'univentionGroupType': ['-2147483646']}
>23.11.2015 22:00:39,100 LDAP        (ALL    ): one_group_member_sync_to_ucs: modlist: [(0, 'uniqueMember', [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'])]
>23.11.2015 22:00:39,104 LDAP        (INFO   ): object_memberships_sync_to_ucs: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group con cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:39,104 LDAP        (INFO   ): Call post_ucs_modify_functions: <function object_memberships_sync_to_ucs at 0x2806848> (done)
>23.11.2015 22:00:39,104 LDAP        (INFO   ): sync_to_ucs: unlock S4 guid: e920529a-d5b0-473e-943d-29e2e626db55
>23.11.2015 22:00:39,104 LDAP        (INFO   ): LockingDB: Execute SQL command: 'DELETE FROM S4_LOCK WHERE guid = ?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:39,105 LDAP        (INFO   ): Return  result for DN (cn=TestGroup3,cn=users,dc=ar41i1,dc=qa)
>23.11.2015 22:00:39,114 LDAP        (INFO   ): _set_lastUSN: new lastUSN is: 3906
>23.11.2015 22:00:40,121 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3907)
>23.11.2015 22:00:40,142 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3907)
>23.11.2015 22:00:40,146 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3907)
>23.11.2015 22:00:40,149 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3907)
>23.11.2015 22:00:40,165 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3907)
>23.11.2015 22:00:40,169 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3907)
>23.11.2015 22:00:45,181 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,181 LDAP        (INFO   ): __sync_file_from_ucs: object was moved
>23.11.2015 22:00:45,183 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,183 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,184 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,184 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,185 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,186 LDAP        (INFO   ): get_object: got object: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,186 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,187 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,187 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,188 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object not found
>23.11.2015 22:00:45,188 LDAP        (INFO   ): samaccount_dn_mapping: got an UCS-Object
>23.11.2015 22:00:45,188 LDAP        (INFO   ): samaccount_dn_mapping: search in s4 for (&(objectclass=group)(samaccountname=TestGroup3))
>23.11.2015 22:00:45,189 LDAP        (INFO   ): samaccount_dn_mapping: newdn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,190 LDAP        (INFO   ): samaccount_dn_mapping: newdn for key olddn:
>23.11.2015 22:00:45,190 LDAP        (INFO   ): samaccount_dn_mapping: olddn: cn=restgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,190 LDAP        (INFO   ): samaccount_dn_mapping: newdn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,192 LDAP        (INFO   ): _ignore_object: Do not ignore cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,192 LDAP        (INFO   ): __sync_file_from_ucs: finished mapping
>23.11.2015 22:00:45,192 LDAP        (INFO   ): sync_from_ucs: sync object: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,193 LDAP        (INFO   ): move group from [cn=restgroup3,cn=users,dc=ar41i1,dc=qa] to [cn=testgroup3,cn=users,DC=ar41i1,DC=qa]
>23.11.2015 22:00:45,193 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,194 LDAP        (INFO   ): samaccount_dn_mapping: not premapped (in first instance)
>23.11.2015 22:00:45,194 LDAP        (INFO   ): samaccount_dn_mapping: got an UCS-Object
>23.11.2015 22:00:45,194 LDAP        (INFO   ): samaccount_dn_mapping: search in s4 for (&(objectclass=group)(samaccountname=TestGroup3))
>23.11.2015 22:00:45,195 LDAP        (INFO   ): samaccount_dn_mapping: newdn: cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,195 LDAP        (INFO   ): samaccount_dn_mapping: newdn for key dn:
>23.11.2015 22:00:45,195 LDAP        (INFO   ): samaccount_dn_mapping: olddn: cn=restgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,196 LDAP        (INFO   ): samaccount_dn_mapping: newdn: cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,196 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,196 LDAP        (INFO   ): samaccount_dn_mapping: not premapped (in first instance)
>23.11.2015 22:00:45,196 LDAP        (INFO   ): samaccount_dn_mapping: got an UCS-Object
>23.11.2015 22:00:45,196 LDAP        (INFO   ): samaccount_dn_mapping: search in s4 for (&(objectclass=group)(samaccountname=TestGroup3))
>23.11.2015 22:00:45,197 LDAP        (INFO   ): samaccount_dn_mapping: newdn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,198 LDAP        (INFO   ): samaccount_dn_mapping: newdn for key olddn:
>23.11.2015 22:00:45,198 LDAP        (INFO   ): samaccount_dn_mapping: olddn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,198 LDAP        (INFO   ): samaccount_dn_mapping: newdn: CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,199 LDAP        (INFO   ): move group from [cn=testgroup3,cn=users,DC=ar41i1,DC=qa] to [cn=testgroup3,cn=users,DC=ar41i1,DC=qa]
>23.11.2015 22:00:45,262 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,263 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,263 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,263 LDAP        (INFO   ): LockingDB: Execute SQL command: 'SELECT id FROM S4_LOCK WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:45,264 LDAP        (INFO   ): LockingDB: Return SQL result: '[]'
>23.11.2015 22:00:45,264 LDAP        (INFO   ): sync_from_ucs: modify object: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,264 LDAP        (INFO   ): sync_from_ucs: old_object: {}
>23.11.2015 22:00:45,265 LDAP        (INFO   ): sync_from_ucs: new_object: {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}
>23.11.2015 22:00:45,265 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: cn
>23.11.2015 22:00:45,265 LDAP        (INFO   ): sync_from_ucs: Found a corresponding mapping defintion: cn
>23.11.2015 22:00:45,266 LDAP        (INFO   ): sync_from_ucs: old_values: set([])
>23.11.2015 22:00:45,266 LDAP        (INFO   ): sync_from_ucs: new_values: set([u'TestGroup3'])
>23.11.2015 22:00:45,266 LDAP        (INFO   ): sync_from_ucs: The current S4 values: set([u'TestGroup3'])
>23.11.2015 22:00:45,266 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: objectClass
>23.11.2015 22:00:45,267 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: univentionObjectType
>23.11.2015 22:00:45,267 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: entryUUID
>23.11.2015 22:00:45,267 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: gidNumber
>23.11.2015 22:00:45,267 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: entryDN
>23.11.2015 22:00:45,268 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: subschemaSubentry
>23.11.2015 22:00:45,268 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: structuralObjectClass
>23.11.2015 22:00:45,268 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: modifyTimestamp
>23.11.2015 22:00:45,268 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: sambaGroupType
>23.11.2015 22:00:45,269 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: hasSubordinates
>23.11.2015 22:00:45,269 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: entryCSN
>23.11.2015 22:00:45,269 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: creatorsName
>23.11.2015 22:00:45,269 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: modifiersName
>23.11.2015 22:00:45,270 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: sambaSID
>23.11.2015 22:00:45,270 LDAP        (INFO   ): sync_from_ucs: Found a corresponding mapping defintion: sid
>23.11.2015 22:00:45,270 LDAP        (INFO   ): sync_from_ucs: sid is in not in write or sync mode. Skipping
>23.11.2015 22:00:45,270 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: createTimestamp
>23.11.2015 22:00:45,271 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: univentionGroupType
>23.11.2015 22:00:45,271 LDAP        (INFO   ): sync_from_ucs: Found a corresponding mapping defintion: groupType
>23.11.2015 22:00:45,271 LDAP        (INFO   ): sync_from_ucs: old_values: set([])
>23.11.2015 22:00:45,271 LDAP        (INFO   ): sync_from_ucs: new_values: set([u'-2147483646'])
>23.11.2015 22:00:45,272 LDAP        (INFO   ): sync_from_ucs: The current S4 values: set([u'-2147483646'])
>23.11.2015 22:00:45,272 LDAP        (ALL    ): nothing to modify: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,272 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0>
>23.11.2015 22:00:45,272 LDAP        (INFO   ): group_members_sync_from_ucs: {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], 'sAMAccountName': [u'TestGroup3'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {}}
>23.11.2015 22:00:45,273 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,273 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,274 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,275 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,275 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,276 LDAP        (INFO   ): group_members_sync_from_ucs: type of object_ucs['dn']: <type 'unicode'>
>23.11.2015 22:00:45,276 LDAP        (INFO   ): group_members_sync_from_ucs: dn is: cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,277 LDAP        (INFO   ): ucs_members: set([])
>23.11.2015 22:00:45,278 LDAP        (INFO   ): group_members_sync_from_ucs: clean ucs_members: set([])
>23.11.2015 22:00:45,279 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,279 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,279 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members set([])
>23.11.2015 22:00:45,279 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-members in s4_members_from_ucs set([])
>23.11.2015 22:00:45,280 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-and S4-members in s4_members_from_ucs set([])
>23.11.2015 22:00:45,280 LDAP        (INFO   ): Search S4 with filter: primaryGroupID=1114
>23.11.2015 22:00:45,281 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members_from_ucs without members with this as their primary group: set([])
>23.11.2015 22:00:45,281 LDAP        (INFO   ): group_members_sync_from_ucs: members to add initialized: set([])
>23.11.2015 22:00:45,282 LDAP        (INFO   ): group_members_sync_from_ucs: members to del initialized: set([])
>23.11.2015 22:00:45,282 LDAP        (INFO   ): group_members_sync_from_ucs: members to add: set([])
>23.11.2015 22:00:45,282 LDAP        (INFO   ): group_members_sync_from_ucs: members to del: set([])
>23.11.2015 22:00:45,282 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0> (done)
>23.11.2015 22:00:45,282 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758>
>23.11.2015 22:00:45,283 LDAP        (INFO   ): object_memberships_sync_from_ucs: object: {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], 'sAMAccountName': [u'TestGroup3'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {}}
>23.11.2015 22:00:45,283 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,283 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,284 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,285 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,285 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,286 LDAP        (INFO   ): object_memberships_sync_from_ucs: is member in 1 groups 
>23.11.2015 22:00:45,287 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,287 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,288 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,288 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,289 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,289 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,290 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,290 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,291 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,291 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,291 LDAP        (INFO   ): one_group_member_sync_from_ucs: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group con cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,292 LDAP        (INFO   ): __group_cache_ucs_append_member: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group ucs cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,292 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758> (done)
>23.11.2015 22:00:45,292 LDAP        (INFO   ): sync_from_ucs: unlock UCS entryUUID: 349c438e-2670-1035-9929-193b4f095a89
>23.11.2015 22:00:45,292 LDAP        (INFO   ): LockingDB: Execute SQL command: 'DELETE FROM UCS_LOCK WHERE uuid = ?;', '('349c438e-2670-1035-9929-193b4f095a89',)'
>23.11.2015 22:00:45,293 LDAP        (ALL    ): sync from ucs return True
>23.11.2015 22:00:45,294 LDAP        (INFO   ): __sync_file_from_ucs: object was modified
>23.11.2015 22:00:45,295 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,295 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,296 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,296 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,297 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,297 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,298 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,298 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,299 LDAP        (INFO   ): _ignore_object: Do not ignore cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,299 LDAP        (INFO   ): __sync_file_from_ucs: finished mapping
>23.11.2015 22:00:45,300 LDAP        (INFO   ): sync_from_ucs: sync object: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,300 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,301 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,301 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,301 LDAP        (INFO   ): LockingDB: Execute SQL command: 'SELECT id FROM S4_LOCK WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:45,301 LDAP        (INFO   ): LockingDB: Return SQL result: '[]'
>23.11.2015 22:00:45,302 LDAP        (INFO   ): sync_from_ucs: modify object: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,302 LDAP        (INFO   ): sync_from_ucs: old_object: {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}
>23.11.2015 22:00:45,302 LDAP        (INFO   ): sync_from_ucs: new_object: {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}
>23.11.2015 22:00:45,302 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: modifyTimestamp
>23.11.2015 22:00:45,303 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: entryCSN
>23.11.2015 22:00:45,303 LDAP        (ALL    ): nothing to modify: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,303 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0>
>23.11.2015 22:00:45,303 LDAP        (INFO   ): group_members_sync_from_ucs: {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'sAMAccountName': [u'TestGroup3'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}}
>23.11.2015 22:00:45,303 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,304 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,305 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,306 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,306 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,306 LDAP        (INFO   ): group_members_sync_from_ucs: type of object_ucs['dn']: <type 'unicode'>
>23.11.2015 22:00:45,306 LDAP        (INFO   ): group_members_sync_from_ucs: dn is: cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,307 LDAP        (INFO   ): ucs_members: set([])
>23.11.2015 22:00:45,308 LDAP        (INFO   ): group_members_sync_from_ucs: clean ucs_members: set([])
>23.11.2015 22:00:45,308 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,309 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,309 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members set([])
>23.11.2015 22:00:45,309 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-members in s4_members_from_ucs set([])
>23.11.2015 22:00:45,309 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-and S4-members in s4_members_from_ucs set([])
>23.11.2015 22:00:45,310 LDAP        (INFO   ): Search S4 with filter: primaryGroupID=1114
>23.11.2015 22:00:45,311 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members_from_ucs without members with this as their primary group: set([])
>23.11.2015 22:00:45,311 LDAP        (INFO   ): group_members_sync_from_ucs: members to add initialized: set([])
>23.11.2015 22:00:45,311 LDAP        (INFO   ): group_members_sync_from_ucs: members to del initialized: set([])
>23.11.2015 22:00:45,311 LDAP        (INFO   ): group_members_sync_from_ucs: members to add: set([])
>23.11.2015 22:00:45,311 LDAP        (INFO   ): group_members_sync_from_ucs: members to del: set([])
>23.11.2015 22:00:45,311 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0> (done)
>23.11.2015 22:00:45,311 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758>
>23.11.2015 22:00:45,312 LDAP        (INFO   ): object_memberships_sync_from_ucs: object: {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'sAMAccountName': [u'TestGroup3'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205500.151350Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'gidNumber': [u'5075'], u'modifyTimestamp': [u'20151123205500Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}}
>23.11.2015 22:00:45,312 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,313 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,313 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,314 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,314 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,315 LDAP        (INFO   ): object_memberships_sync_from_ucs: is member in 1 groups 
>23.11.2015 22:00:45,316 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,316 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,316 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,317 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,317 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,318 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,318 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,318 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,319 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,319 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,319 LDAP        (INFO   ): one_group_member_sync_from_ucs: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group con cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,319 LDAP        (INFO   ): __group_cache_ucs_append_member: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group ucs cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,320 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758> (done)
>23.11.2015 22:00:45,320 LDAP        (INFO   ): sync_from_ucs: unlock UCS entryUUID: 349c438e-2670-1035-9929-193b4f095a89
>23.11.2015 22:00:45,320 LDAP        (INFO   ): LockingDB: Execute SQL command: 'DELETE FROM UCS_LOCK WHERE uuid = ?;', '('349c438e-2670-1035-9929-193b4f095a89',)'
>23.11.2015 22:00:45,320 LDAP        (ALL    ): sync from ucs return True
>23.11.2015 22:00:45,321 LDAP        (INFO   ): __sync_file_from_ucs: object was modified
>23.11.2015 22:00:45,322 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,323 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,323 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,323 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,324 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,324 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,325 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,325 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,326 LDAP        (INFO   ): _ignore_object: Do not ignore cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,326 LDAP        (INFO   ): __sync_file_from_ucs: finished mapping
>23.11.2015 22:00:45,326 LDAP        (INFO   ): sync_from_ucs: sync object: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,327 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,327 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,327 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,328 LDAP        (INFO   ): LockingDB: Execute SQL command: 'SELECT id FROM S4_LOCK WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:45,328 LDAP        (INFO   ): LockingDB: Return SQL result: '[]'
>23.11.2015 22:00:45,328 LDAP        (INFO   ): sync_from_ucs: modify object: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,328 LDAP        (INFO   ): sync_from_ucs: old_object: {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}
>23.11.2015 22:00:45,329 LDAP        (INFO   ): sync_from_ucs: new_object: {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.998171Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}
>23.11.2015 22:00:45,329 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: entryCSN
>23.11.2015 22:00:45,329 LDAP        (ALL    ): nothing to modify: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,329 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0>
>23.11.2015 22:00:45,329 LDAP        (INFO   ): group_members_sync_from_ucs: {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.998171Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'sAMAccountName': [u'TestGroup3'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.998171Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}}
>23.11.2015 22:00:45,330 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,330 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,331 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,331 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,332 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,332 LDAP        (INFO   ): group_members_sync_from_ucs: type of object_ucs['dn']: <type 'unicode'>
>23.11.2015 22:00:45,332 LDAP        (INFO   ): group_members_sync_from_ucs: dn is: cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,333 LDAP        (INFO   ): ucs_members: set([])
>23.11.2015 22:00:45,333 LDAP        (INFO   ): group_members_sync_from_ucs: clean ucs_members: set([])
>23.11.2015 22:00:45,334 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,334 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,334 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members set([])
>23.11.2015 22:00:45,335 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-members in s4_members_from_ucs set([])
>23.11.2015 22:00:45,335 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-and S4-members in s4_members_from_ucs set([])
>23.11.2015 22:00:45,335 LDAP        (INFO   ): Search S4 with filter: primaryGroupID=1114
>23.11.2015 22:00:45,336 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members_from_ucs without members with this as their primary group: set([])
>23.11.2015 22:00:45,336 LDAP        (INFO   ): group_members_sync_from_ucs: members to add initialized: set([])
>23.11.2015 22:00:45,336 LDAP        (INFO   ): group_members_sync_from_ucs: members to del initialized: set([])
>23.11.2015 22:00:45,336 LDAP        (INFO   ): group_members_sync_from_ucs: members to add: set([])
>23.11.2015 22:00:45,336 LDAP        (INFO   ): group_members_sync_from_ucs: members to del: set([])
>23.11.2015 22:00:45,337 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0> (done)
>23.11.2015 22:00:45,337 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758>
>23.11.2015 22:00:45,337 LDAP        (INFO   ): object_memberships_sync_from_ucs: object: {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.998171Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'sAMAccountName': [u'TestGroup3'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.998171Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210038.956732Z#000000#000#000000'], u'cn': [u'TestGroup3'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'349c438e-2670-1035-9929-193b4f095a89'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], u'modifyTimestamp': [u'20151123210038Z'], u'gidNumber': [u'5075'], u'createTimestamp': [u'20151123205500Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}}
>23.11.2015 22:00:45,337 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,338 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,338 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,339 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,339 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,340 LDAP        (INFO   ): object_memberships_sync_from_ucs: is member in 1 groups 
>23.11.2015 22:00:45,340 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,341 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,341 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,341 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,342 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,342 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,342 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,342 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,343 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,343 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,344 LDAP        (INFO   ): one_group_member_sync_from_ucs: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group con cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,344 LDAP        (INFO   ): __group_cache_ucs_append_member: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group ucs cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,344 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758> (done)
>23.11.2015 22:00:45,344 LDAP        (INFO   ): sync_from_ucs: unlock UCS entryUUID: 349c438e-2670-1035-9929-193b4f095a89
>23.11.2015 22:00:45,344 LDAP        (INFO   ): LockingDB: Execute SQL command: 'DELETE FROM UCS_LOCK WHERE uuid = ?;', '('349c438e-2670-1035-9929-193b4f095a89',)'
>23.11.2015 22:00:45,345 LDAP        (ALL    ): sync from ucs return True
>23.11.2015 22:00:45,346 LDAP        (INFO   ): __sync_file_from_ucs: object was modified
>23.11.2015 22:00:45,347 LDAP        (INFO   ): _ignore_object: Do not ignore cn=TestGroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,347 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,347 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,348 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,348 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,349 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,349 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,349 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,350 LDAP        (INFO   ): _ignore_object: Do not ignore cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,350 LDAP        (INFO   ): __sync_file_from_ucs: finished mapping
>23.11.2015 22:00:45,350 LDAP        (INFO   ): sync_from_ucs: sync object: cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,351 LDAP        (PROCESS): sync from ucs: [         group] [    modify] cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,351 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,351 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,352 LDAP        (INFO   ): LockingDB: Execute SQL command: 'SELECT id FROM S4_LOCK WHERE guid=?;', '('35afa9e6-537e-4576-899b-d7836d03d4ce',)'
>23.11.2015 22:00:45,352 LDAP        (INFO   ): LockingDB: Return SQL result: '[]'
>23.11.2015 22:00:45,352 LDAP        (INFO   ): sync_from_ucs: modify object: cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,352 LDAP        (INFO   ): sync_from_ucs: old_object: {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205517.666767Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], u'modifyTimestamp': [u'20151123205517Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}
>23.11.2015 22:00:45,352 LDAP        (INFO   ): sync_from_ucs: new_object: {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210039.100722Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], u'modifyTimestamp': [u'20151123210039Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa', u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}
>23.11.2015 22:00:45,352 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: modifyTimestamp
>23.11.2015 22:00:45,353 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: entryCSN
>23.11.2015 22:00:45,353 LDAP        (INFO   ): sync_from_ucs: The following attribute has been changed: uniqueMember
>23.11.2015 22:00:45,353 LDAP        (ALL    ): nothing to modify: cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,353 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0>
>23.11.2015 22:00:45,353 LDAP        (INFO   ): group_members_sync_from_ucs: {'dn': u'cn=testgroup1,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210039.100722Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], 'sAMAccountName': [u'TestGroup1'], u'modifyTimestamp': [u'20151123210039Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa', u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210039.100722Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], u'modifyTimestamp': [u'20151123210039Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa', u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205517.666767Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], u'modifyTimestamp': [u'20151123205517Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}}
>23.11.2015 22:00:45,354 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,354 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,355 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,355 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,355 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,356 LDAP        (INFO   ): group_members_sync_from_ucs: type of object_ucs['dn']: <type 'unicode'>
>23.11.2015 22:00:45,356 LDAP        (INFO   ): group_members_sync_from_ucs: dn is: cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,356 LDAP        (INFO   ): ucs_members: set(['cn=restgroup3,cn=users,dc=ar41i1,dc=qa', 'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa', 'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'])
>23.11.2015 22:00:45,357 LDAP        (INFO   ): group_members_sync_from_ucs: clean ucs_members: set(['cn=restgroup3,cn=users,dc=ar41i1,dc=qa', 'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa', 'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'])
>23.11.2015 22:00:45,358 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,358 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,358 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members set([u'CN=testgroup3,CN=Users,DC=ar41i1,DC=qa', u'CN=TestGroup2,CN=Users,DC=ar41i1,DC=qa'])
>23.11.2015 22:00:45,358 LDAP        (INFO   ): Did not find cn=restgroup3,cn=users,dc=ar41i1,dc=qa in group cache ucs
>23.11.2015 22:00:45,359 LDAP        (INFO   ): Did not find cn=TestGroup3,cn=users,dc=ar41i1,dc=qa in group cache ucs
>23.11.2015 22:00:45,359 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,359 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,360 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,360 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,361 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,361 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,361 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,361 LDAP        (INFO   ): __group_cache_ucs_append_member: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group ucs cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,362 LDAP        (INFO   ): Did not find cn=testgroup2,cn=users,dc=ar41i1,dc=qa in group cache ucs
>23.11.2015 22:00:45,362 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:45,362 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:45,363 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,363 LDAP        (INFO   ): get_object: got object: CN=TestGroup2,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,363 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:45,364 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:45,364 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,364 LDAP        (INFO   ): __group_cache_ucs_append_member: Append user cn=testgroup2,cn=users,dc=ar41i1,dc=qa to group ucs cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:45,364 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-members in s4_members_from_ucs set([u'cn=testgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'])
>23.11.2015 22:00:45,365 LDAP        (INFO   ): group_members_sync_from_ucs: UCS-and S4-members in s4_members_from_ucs set([u'cn=testgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'])
>23.11.2015 22:00:45,365 LDAP        (INFO   ): Search S4 with filter: primaryGroupID=1112
>23.11.2015 22:00:45,366 LDAP        (INFO   ): group_members_sync_from_ucs: s4_members_from_ucs without members with this as their primary group: set([u'cn=testgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'])
>23.11.2015 22:00:45,366 LDAP        (INFO   ): group_members_sync_from_ucs: members to add initialized: set([u'cn=testgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'])
>23.11.2015 22:00:45,366 LDAP        (INFO   ): group_members_sync_from_ucs: members to del initialized: set([])
>23.11.2015 22:00:45,366 LDAP        (INFO   ): group_members_sync_from_ucs: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa in s4_members_from_ucs?
>23.11.2015 22:00:45,366 LDAP        (INFO   ): group_members_sync_from_ucs: Yes
>23.11.2015 22:00:45,366 LDAP        (INFO   ): group_members_sync_from_ucs: CN=TestGroup2,CN=Users,DC=ar41i1,DC=qa in s4_members_from_ucs?
>23.11.2015 22:00:45,366 LDAP        (INFO   ): group_members_sync_from_ucs: Yes
>23.11.2015 22:00:45,367 LDAP        (INFO   ): group_members_sync_from_ucs: members to add: set([])
>23.11.2015 22:00:45,367 LDAP        (INFO   ): group_members_sync_from_ucs: members to del: set([])
>23.11.2015 22:00:45,367 LDAP        (INFO   ): Call post_con_modify_functions: <function group_members_sync_from_ucs at 0x28066e0> (done)
>23.11.2015 22:00:45,367 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758>
>23.11.2015 22:00:45,367 LDAP        (INFO   ): object_memberships_sync_from_ucs: object: {'dn': u'cn=testgroup1,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210039.100722Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], 'sAMAccountName': [u'TestGroup1'], u'modifyTimestamp': [u'20151123210039Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa', u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'modtype': 'modify', 'new_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123210039.100722Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], u'modifyTimestamp': [u'20151123210039Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa', u'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}, 'old_ucs_object': {u'sambaGroupType': [u'2'], u'hasSubordinates': [u'FALSE'], u'entryCSN': [u'20151123205517.666767Z#000000#000#000000'], u'cn': [u'TestGroup1'], u'objectClass': [u'top', u'univentionGroup', u'posixGroup', u'univentionObject', u'sambaGroupMapping'], u'univentionObjectType': [u'groups/group'], u'entryUUID': [u'2bcfad86-2670-1035-991f-193b4f095a89'], u'gidNumber': [u'5073'], u'modifyTimestamp': [u'20151123205517Z'], u'sambaSID': [u'S-1-5-21-2660895256-1678062113-3852026326-1112'], u'createTimestamp': [u'20151123205445Z'], u'modifiersName': [u'cn=admin,dc=ar41i1,dc=qa'], u'entryDN': [u'cn=TestGroup1,cn=users,dc=ar41i1,dc=qa'], u'subschemaSubentry': [u'cn=Subschema'], u'structuralObjectClass': [u'posixGroup'], u'uniqueMember': [u'cn=restgroup3,cn=users,dc=ar41i1,dc=qa', u'cn=testgroup2,cn=users,dc=ar41i1,dc=qa'], u'creatorsName': [u'cn=admin,dc=ar41i1,dc=qa'], u'univentionGroupType': [u'-2147483646']}}
>23.11.2015 22:00:45,367 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:45,368 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:45,368 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:45,369 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:45,369 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:45,370 LDAP        (INFO   ): object_memberships_sync_from_ucs: No group-memberships in UCS for cn=testgroup1,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:45,370 LDAP        (INFO   ): Call post_con_modify_functions: <function object_memberships_sync_from_ucs at 0x2806758> (done)
>23.11.2015 22:00:45,370 LDAP        (INFO   ): sync_from_ucs: unlock UCS entryUUID: 2bcfad86-2670-1035-991f-193b4f095a89
>23.11.2015 22:00:45,370 LDAP        (INFO   ): LockingDB: Execute SQL command: 'DELETE FROM UCS_LOCK WHERE uuid = ?;', '('2bcfad86-2670-1035-991f-193b4f095a89',)'
>23.11.2015 22:00:45,370 LDAP        (ALL    ): sync from ucs return True
>23.11.2015 22:00:46,373 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3907)
>23.11.2015 22:00:46,393 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3907)
>23.11.2015 22:00:46,396 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3907)
>23.11.2015 22:00:46,399 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3907)
>23.11.2015 22:00:46,414 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:46,414 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3907)
>23.11.2015 22:00:46,417 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3907)
>23.11.2015 22:00:46,420 LDAP        (INFO   ): object_from_element: olddn: cn=testgroup3,cn=users,DC=ar41i1,DC=qa
>23.11.2015 22:00:46,422 LDAP        (INFO   ): _ignore_object: Do not ignore CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:46,422 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:46,422 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:46,423 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:46,423 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:46,423 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:46,424 LDAP        (INFO   ): sid_to_ucs_mapping
>23.11.2015 22:00:46,424 LDAP        (INFO   ): _ignore_object: Do not ignore cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:46,426 LDAP        (INFO   ): get_ucs_object: object found: cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:46,426 LDAP        (PROCESS): sync to ucs:   [         group] [    modify] cn=testgroup3,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:46,426 LDAP        (INFO   ): sync_to_ucs: set position to cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:46,427 LDAP        (INFO   ): LockingDB: Execute SQL command: 'SELECT id FROM UCS_LOCK WHERE uuid=?;', '('349c438e-2670-1035-9929-193b4f095a89',)'
>23.11.2015 22:00:46,427 LDAP        (INFO   ): LockingDB: Return SQL result: '[]'
>23.11.2015 22:00:46,427 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:46,427 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:46,428 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT ATTRIBUTES.attribute,data.value from data 					inner join ATTRIBUTES ON data.attribute_id=attributes.id where guid_id = ?;', '('74',)'
>23.11.2015 22:00:46,428 LDAP        (INFO   ): S4Cache: Return SQL result: '[(u'distinguishedName', u'Q049VGVzdEdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n'), (u'cn', u'VGVzdEdyb3VwMw==\n'), (u'objectCategory', u'Q049R3JvdXAsQ049U2NoZW1hLENOPUNvbmZpZ3VyYXRpb24sREM9YXI0MWkxLERDPXFh\n'), (u'objectClass', u'dG9w\n'), (u'objectClass', u'Z3JvdXA=\n'), (u'objectGUID', u'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n'), (u'whenCreated', u'MjAxNTExMjMyMDU0NTQuMFo=\n'), (u'uSNCreated', u'MzkwMg==\n'), (u'uSNChanged', u'MzkwNg==\n'), (u'whenChanged', u'MjAxNTExMjMyMTAwMzUuMFo=\n'), (u'instanceType', u'NA==\n'), (u'name', u'VGVzdEdyb3VwMw==\n'), (u'objectSid', u'Uy0xLTUtMjEtMjY2MDg5NTI1Ni0xNjc4MDYyMTEzLTM4NTIwMjYzMjYtMTExNA==\n'), (u'groupType', u'LTIxNDc0ODM2NDY=\n'), (u'memberOf', u'Q049VGVzdEdyb3VwMSxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n'), (u'sAMAccountName', u'VGVzdEdyb3VwMw==\n'), (u'sAMAccountType', u'MjY4NDM1NDU2\n')]'
>23.11.2015 22:00:46,428 LDAP        (INFO   ): sync_to_ucs: old_s4_object: {'distinguishedName': ['CN=TestGroup3,CN=Users,DC=ar41i1,DC=qa'], 'groupType': ['-2147483646'], 'cn': ['TestGroup3'], 'objectCategory': ['CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': ['top', 'group'], 'memberOf': ['CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': ['\xc2\x9aR \xc3\xa9\xc2\xb0\xc3\x95>G\xc2\x94=)\xc3\xa2\xc3\xa6&\xc3\x9bU'], 'sAMAccountName': ['TestGroup3'], 'whenChanged': ['20151123210035.0Z'], 'sAMAccountType': ['268435456'], 'objectSid': ['S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': ['20151123205454.0Z'], 'uSNCreated': ['3902'], 'uSNChanged': ['3906'], 'instanceType': ['4'], 'name': ['TestGroup3']}
>23.11.2015 22:00:46,428 LDAP        (INFO   ): sync_to_ucs: new_s4_object: {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=testgroup3,CN=Users,DC=ar41i1,DC=qa'], 'sAMAccountName': [u'TestGroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'name': [u'testgroup3'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3907'], 'whenChanged': [u'20151123210045.0Z'], 'instanceType': [u'4'], 'cn': [u'testgroup3']}
>23.11.2015 22:00:46,429 LDAP        (INFO   ): The following attributes have been changed: ['distinguishedName', 'name', 'uSNChanged', 'whenChanged', 'cn']
>23.11.2015 22:00:46,430 LDAP        (INFO   ): __set_values: object: {'dn': u'cn=testgroup3,cn=users,dc=ar41i1,dc=qa', 'attributes': {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=testgroup3,CN=Users,DC=ar41i1,DC=qa'], 'cn': [u'TestGroup3'], 'name': [u'testgroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'sambaSID': u'1114', 'whenChanged': [u'20151123210045.0Z'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3907'], 'univentionGroupType': [u'-2147483646'], 'instanceType': [u'4'], 'sAMAccountName': [u'TestGroup3']}, 'changed_attributes': ['distinguishedName', 'name', 'uSNChanged', 'whenChanged', 'cn'], 'modtype': 'modify'}
>23.11.2015 22:00:46,430 LDAP        (INFO   ): __set_values: Skip: groupType
>23.11.2015 22:00:46,430 LDAP        (INFO   ): __set_values: Skip: objectSid
>23.11.2015 22:00:46,431 LDAP        (INFO   ): __set_values: Skip: mail
>23.11.2015 22:00:46,431 LDAP        (INFO   ): __set_values: Skip: sAMAccountName
>23.11.2015 22:00:46,431 LDAP        (INFO   ): __set_values: Skip: description
>23.11.2015 22:00:46,432 LDAP        (INFO   ): __modify_custom_attributes: no custom attributes found
>23.11.2015 22:00:46,432 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:46,432 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:46,432 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:46,432 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:46,433 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:46,433 LDAP        (INFO   ): S4Cache: Return SQL result: '[(74,)]'
>23.11.2015 22:00:46,433 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT ATTRIBUTES.attribute,data.value from data 					inner join ATTRIBUTES ON data.attribute_id=attributes.id where guid_id = ?;', '('74',)'
>23.11.2015 22:00:46,433 LDAP        (INFO   ): S4Cache: Return SQL result: '[(u'distinguishedName', u'Q049VGVzdEdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n'), (u'cn', u'VGVzdEdyb3VwMw==\n'), (u'objectCategory', u'Q049R3JvdXAsQ049U2NoZW1hLENOPUNvbmZpZ3VyYXRpb24sREM9YXI0MWkxLERDPXFh\n'), (u'objectClass', u'dG9w\n'), (u'objectClass', u'Z3JvdXA=\n'), (u'objectGUID', u'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n'), (u'whenCreated', u'MjAxNTExMjMyMDU0NTQuMFo=\n'), (u'uSNCreated', u'MzkwMg==\n'), (u'uSNChanged', u'MzkwNg==\n'), (u'whenChanged', u'MjAxNTExMjMyMTAwMzUuMFo=\n'), (u'instanceType', u'NA==\n'), (u'name', u'VGVzdEdyb3VwMw==\n'), (u'objectSid', u'Uy0xLTUtMjEtMjY2MDg5NTI1Ni0xNjc4MDYyMTEzLTM4NTIwMjYzMjYtMTExNA==\n'), (u'groupType', u'LTIxNDc0ODM2NDY=\n'), (u'memberOf', u'Q049VGVzdEdyb3VwMSxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n'), (u'sAMAccountName', u'VGVzdEdyb3VwMw==\n'), (u'sAMAccountType', u'MjY4NDM1NDU2\n')]'
>23.11.2015 22:00:46,434 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('distinguishedName',)'
>23.11.2015 22:00:46,434 LDAP        (INFO   ): S4Cache: Return SQL result: '[(1,)]'
>23.11.2015 22:00:46,434 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('cn',)'
>23.11.2015 22:00:46,434 LDAP        (INFO   ): S4Cache: Return SQL result: '[(3,)]'
>23.11.2015 22:00:46,434 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('objectGUID',)'
>23.11.2015 22:00:46,434 LDAP        (INFO   ): S4Cache: Return SQL result: '[(7,)]'
>23.11.2015 22:00:46,435 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('whenChanged',)'
>23.11.2015 22:00:46,435 LDAP        (INFO   ): S4Cache: Return SQL result: '[(13,)]'
>23.11.2015 22:00:46,435 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('uSNChanged',)'
>23.11.2015 22:00:46,435 LDAP        (INFO   ): S4Cache: Return SQL result: '[(12,)]'
>23.11.2015 22:00:46,435 LDAP        (INFO   ): S4Cache: Execute SQL command: 'SELECT id FROM ATTRIBUTES WHERE attribute=?;', '('name',)'
>23.11.2015 22:00:46,435 LDAP        (INFO   ): S4Cache: Return SQL result: '[(15,)]'
>23.11.2015 22:00:46,436 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('1', '74', 'Q049VGVzdEdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n')'
>23.11.2015 22:00:46,436 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '1', 'Q049dGVzdGdyb3VwMyxDTj1Vc2VycyxEQz1hcjQxaTEsREM9cWE=\n')'
>23.11.2015 22:00:46,436 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('3', '74', 'VGVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:46,436 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '3', 'dGVzdGdyb3VwMw==\n')'
>23.11.2015 22:00:46,436 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('7', '74', 'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n')'
>23.11.2015 22:00:46,437 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '7', 'wppSIMOpwrDDlT5HwpQ9KcOiw6Ymw5tV\n')'
>23.11.2015 22:00:46,437 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('13', '74', 'MjAxNTExMjMyMTAwMzUuMFo=\n')'
>23.11.2015 22:00:46,437 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '13', 'MjAxNTExMjMyMTAwNDUuMFo=\n')'
>23.11.2015 22:00:46,437 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('12', '74', 'MzkwNg==\n')'
>23.11.2015 22:00:46,437 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '12', 'MzkwNw==\n')'
>23.11.2015 22:00:46,437 LDAP        (INFO   ): S4Cache: Execute SQL command: 'DELETE FROM data WHERE data.id IN (							SELECT data.id FROM DATA INNER JOIN ATTRIBUTES ON data.attribute_id=attributes.id 							where attributes.id=? and guid_id = ? and value = ? 						);', '('15', '74', 'VGVzdEdyb3VwMw==\n')'
>23.11.2015 22:00:46,438 LDAP        (INFO   ): S4Cache: Execute SQL command: 'INSERT INTO DATA(guid_id,attribute_id,value) VALUES(?,?,?);', '('74', '15', 'dGVzdGdyb3VwMw==\n')'
>23.11.2015 22:00:46,446 LDAP        (INFO   ): Call post_ucs_modify_functions: <function group_members_sync_to_ucs at 0x28067d0>
>23.11.2015 22:00:46,446 LDAP        (INFO   ): group_members_sync_to_ucs: object: {'dn': u'cn=testgroup3,cn=users,dc=ar41i1,dc=qa', 'attributes': {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=testgroup3,CN=Users,DC=ar41i1,DC=qa'], 'cn': [u'TestGroup3'], 'name': [u'testgroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'sambaSID': u'1114', 'whenChanged': [u'20151123210045.0Z'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3907'], 'univentionGroupType': [u'-2147483646'], 'instanceType': [u'4'], 'sAMAccountName': [u'TestGroup3']}, 'changed_attributes': ['distinguishedName', 'name', 'uSNChanged', 'whenChanged', 'cn'], 'modtype': 'modify'}
>23.11.2015 22:00:46,446 LDAP        (INFO   ): _object_mapping: map with key group and type ucs
>23.11.2015 22:00:46,447 LDAP        (INFO   ): _dn_type ucs
>23.11.2015 22:00:46,448 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:46,449 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:46,449 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:46,450 LDAP        (INFO   ): samaccount_dn_mapping: premapped S4 object found
>23.11.2015 22:00:46,450 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:46,450 LDAP        (INFO   ): group_members_sync_to_ucs: s4_object (mapped): {'dn': u'cn=testgroup3,cn=users,DC=ar41i1,DC=qa', 'attributes': {'groupType': [u'-2147483646'], 'distinguishedName': [u'CN=testgroup3,CN=Users,DC=ar41i1,DC=qa'], 'cn': [u'TestGroup3'], 'name': [u'testgroup3'], 'objectCategory': [u'CN=Group,CN=Schema,CN=Configuration,DC=ar41i1,DC=qa'], 'objectClass': [u'top', u'group'], 'memberOf': [u'CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa'], 'objectGUID': [u'\x9aR \xe9\xb0\xd5>G\x94=)\xe2\xe6&\xdbU'], 'sambaSID': u'1114', 'whenChanged': [u'20151123210045.0Z'], 'sAMAccountType': [u'268435456'], 'objectSid': [u'S-1-5-21-2660895256-1678062113-3852026326-1114'], 'whenCreated': [u'20151123205454.0Z'], 'uSNCreated': [u'3902'], 'uSNChanged': [u'3907'], 'univentionGroupType': [u'-2147483646'], 'instanceType': [u'4'], 'sAMAccountName': [u'TestGroup3']}, 'changed_attributes': ['distinguishedName', 'name', 'uSNChanged', 'whenChanged', 'cn'], 'modtype': 'modify'}
>23.11.2015 22:00:46,451 LDAP        (INFO   ): group_members_sync_to_ucs: ucs_members: set([])
>23.11.2015 22:00:46,452 LDAP        (INFO   ): get_object: got object: CN=testgroup3,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:46,453 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:46,454 LDAP        (INFO   ): group_members_sync_to_ucs: s4_members []
>23.11.2015 22:00:46,454 LDAP        (INFO   ): group_members_sync_to_ucs: Reset con cache
>23.11.2015 22:00:46,454 LDAP        (INFO   ): group_members_sync_to_ucs: dn_mapping_ucs_member_to_s4={}
>23.11.2015 22:00:46,454 LDAP        (INFO   ): group_members_sync_to_ucs: ucs_members: set([])
>23.11.2015 22:00:46,455 LDAP        (INFO   ): group_members_sync_to_ucs: ucs_members_from_s4: {'unknown': [], 'group': [], 'user': []}
>23.11.2015 22:00:46,455 LDAP        (INFO   ): group_members_sync_to_ucs: members to add: {'unknown': [], 'group': [], 'user': []}
>23.11.2015 22:00:46,455 LDAP        (INFO   ): group_members_sync_to_ucs: members to del: {'group': [], 'user': []}
>23.11.2015 22:00:46,455 LDAP        (INFO   ): Call post_ucs_modify_functions: <function group_members_sync_to_ucs at 0x28067d0> (done)
>23.11.2015 22:00:46,456 LDAP        (INFO   ): Call post_ucs_modify_functions: <function object_memberships_sync_to_ucs at 0x2806848>
>23.11.2015 22:00:46,456 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:46,456 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:46,457 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:46,458 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:46,458 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:46,458 LDAP        (INFO   ): sid_to_ucs_mapping
>23.11.2015 22:00:46,459 LDAP        (INFO   ): get_object: got object: CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:46,460 LDAP        (INFO   ): encode_s4_object: attrib objectGUID ignored during encoding
>23.11.2015 22:00:46,461 LDAP        (INFO   ): _ignore_object: Do not ignore CN=TestGroup1,CN=Users,DC=ar41i1,DC=qa
>23.11.2015 22:00:46,461 LDAP        (INFO   ): _object_mapping: map with key group and type con
>23.11.2015 22:00:46,462 LDAP        (INFO   ): _dn_type con
>23.11.2015 22:00:46,462 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key dn:
>23.11.2015 22:00:46,463 LDAP        (INFO   ): samaccount_dn_mapping: premapped UCS object found
>23.11.2015 22:00:46,463 LDAP        (INFO   ): samaccount_dn_mapping: check newdn for key olddn:
>23.11.2015 22:00:46,464 LDAP        (INFO   ): sid_to_ucs_mapping
>23.11.2015 22:00:46,465 LDAP        (INFO   ): object_memberships_sync_to_ucs: sync_object: {'sambaGroupType': ['2'], 'cn': ['TestGroup1'], 'objectClass': ['top', 'univentionGroup', 'posixGroup', 'univentionObject', 'sambaGroupMapping'], 'univentionObjectType': ['groups/group'], 'sambaSID': ['S-1-5-21-2660895256-1678062113-3852026326-1112'], 'gidNumber': ['5073'], 'uniqueMember': ['cn=restgroup3,cn=users,dc=ar41i1,dc=qa', 'cn=testgroup2,cn=users,dc=ar41i1,dc=qa', 'cn=TestGroup3,cn=users,dc=ar41i1,dc=qa'], 'univentionGroupType': ['-2147483646']}
>23.11.2015 22:00:46,465 LDAP        (INFO   ): object_memberships_sync_to_ucs: Append user cn=testgroup3,cn=users,dc=ar41i1,dc=qa to group con cache of cn=testgroup1,cn=users,dc=ar41i1,dc=qa
>23.11.2015 22:00:46,465 LDAP        (INFO   ): Call post_ucs_modify_functions: <function object_memberships_sync_to_ucs at 0x2806848> (done)
>23.11.2015 22:00:46,465 LDAP        (INFO   ): sync_to_ucs: unlock S4 guid: e920529a-d5b0-473e-943d-29e2e626db55
>23.11.2015 22:00:46,466 LDAP        (INFO   ): LockingDB: Execute SQL command: 'DELETE FROM S4_LOCK WHERE guid = ?;', '('e920529a-d5b0-473e-943d-29e2e626db55',)'
>23.11.2015 22:00:46,466 LDAP        (INFO   ): Return  result for DN (cn=testgroup3,cn=users,dc=ar41i1,dc=qa)
>23.11.2015 22:00:46,473 LDAP        (INFO   ): _set_lastUSN: new lastUSN is: 3907
>23.11.2015 22:00:47,480 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:47,497 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:47,500 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:47,502 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:47,517 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:47,520 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:52,529 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:52,552 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:52,556 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:52,559 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:52,577 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:52,581 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:57,599 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:57,620 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:57,625 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:00:57,628 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:57,645 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:00:57,649 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:02,659 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:02,681 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:02,685 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:02,688 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:02,706 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:02,710 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:07,720 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:07,743 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:07,747 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:07,750 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:07,768 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:07,771 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:12,781 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:12,799 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:12,802 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:12,804 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:12,818 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:12,821 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:17,842 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:17,864 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:17,869 LDAP        (INFO   ): Search S4 with filter: (uSNCreated>=3908)
>23.11.2015 22:01:17,871 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:17,889 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)
>23.11.2015 22:01:17,893 LDAP        (INFO   ): Search S4 with filter: (uSNChanged>=3908)

Actions: View

Attachments on bug 42840: 8183 | 8256 | 8257