28.06.2019 13:45:44.856 LDAP (PROCESS): sync to ucs: Resync rejected dn: CN=cschein,CN=Users,DC=schein,DC=me 28.06.2019 13:45:44.856 LDAP (INFO ): Search S4 with filter: (|(uSNChanged=4622)(uSNCreated=4622)) 28.06.2019 13:45:44.858 LDAP (INFO ): encode_s4_object: attrib objectGUID ignored during encoding 28.06.2019 13:45:44.859 LDAP (INFO ): Search S4 with filter: (|(uSNChanged=4622)(uSNCreated=4622)) 28.06.2019 13:45:44.860 LDAP (INFO ): Search S4 with filter: (|(uSNChanged=4622)(uSNCreated=4622)) 28.06.2019 13:45:44.861 LDAP (INFO ): object_from_element: olddn: CN=cschein,CN=Users,DC=schein,DC=me 28.06.2019 13:45:44.862 LDAP (INFO ): _object_mapping: map with key user and type con 28.06.2019 13:45:44.863 LDAP (INFO ): _dn_type con 28.06.2019 13:45:44.863 LDAP (INFO ): samaccount_dn_mapping: check newdn for key dn: uid=cschein,cn=users,dc=schein,dc=me 28.06.2019 13:45:44.865 LDAP (INFO ): samaccount_dn_mapping: premapped UCS object found 28.06.2019 13:45:44.865 LDAP (INFO ): samaccount_dn_mapping: check newdn for key olddn: None 28.06.2019 13:45:44.868 LDAP (INFO ): _ignore_object: Do not ignore uid=cschein,cn=users,dc=schein,dc=me 28.06.2019 13:45:44.869 LDAP (INFO ): _ignore_object: Do not ignore CN=cschein,CN=Users,DC=schein,DC=me 28.06.2019 13:45:44.872 LDAP (INFO ): get_ucs_object: object found: uid=cschein,cn=users,dc=schein,dc=me 28.06.2019 13:45:44.872 LDAP (PROCESS): sync to ucs: [ user] [ modify] uid=cschein,cn=users,dc=schein,dc=me 28.06.2019 13:45:44.873 LDAP (INFO ): sync_to_ucs: set position to cn=users,dc=schein,dc=me 28.06.2019 13:45:44.874 LDAP (INFO ): LockingDB: Execute SQL command: 'SELECT id FROM UCS_LOCK WHERE uuid=?;', '('f455ad0a-592b-1038-98e3-95cd4e44d99b',)' 28.06.2019 13:45:44.874 LDAP (INFO ): LockingDB: Return SQL result: '[]' 28.06.2019 13:45:44.874 LDAP (INFO ): S4Cache: Execute SQL command: 'SELECT id FROM GUIDS WHERE guid=?;', '('923cad2b-42b6-4cca-97c2-9dbb9a841975',)' 28.06.2019 13:45:44.875 LDAP (INFO ): S4Cache: Return SQL result: '[(225,)]' 28.06.2019 13:45:44.875 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 = ?;', '('225',)' 28.06.2019 13:45:44.875 LDAP (INFO ): S4Cache: Return SQL result: '[(u'distinguishedName', u'Q049Y3NjaGVpbixDTj1Vc2VycyxEQz1zY2hlaW4sREM9bWU=\n'), (u'cn', u'Y3NjaGVpbg==\n'), (u'objectCategory', u'Q049UGVyc29uLENOPVNjaGVtYSxDTj1Db25maWd1cmF0aW9uLERDPXNjaGVpbixEQz1tZQ==\n'), (u'objectClass', u'dG9w\n'), (u'objectClass', u'cGVyc29u\n'), (u'objectClass', u'b3JnYW5pemF0aW9uYWxQZXJzb24=\n'), (u'objectClass', u'dXNlcg==\n'), (u'objectGUID', u'K8KtPMKSwrZCw4pMwpfDgsKdwrvCmsKEGXU=\n'), (u'whenCreated', u'MjAxODExMjgwMDM0MzcuMFo=\n'), (u'uSNCreated', u'Mzc5MQ==\n'), (u'uSNChanged', u'NDYyMA==\n'), (u'whenChanged', u'MjAxOTA2MjgxMTQ0MjIuMFo=\n'), (u'instanceType', u'NA==\n '), (u'name', u'Y3NjaGVpbg==\n'), (u'objectSid', u'Uy0xLTUtMjEtMTk2NTI3MzU2MC0yNTE4ODkzODgxLTIxNjY5MTg1ODAtNTQxMjg=\n'), (u'primaryGroupID', u'NTEz\n'), (u'logonCount', u'MQ==\n'), (u'countryCode', u'MA==\n'), (u'userPrincipalName', u'Y3NjaGVpbkBTQ0hFSU4uTUU=\n'), (u'sAMAccountType', u'ODA1MzA2MzY4\n'), (u'lockoutTime', u'MA==\n'), (u'badPasswordTime', u'MA==\n'), (u'pwdLastSet', u'MTMxODI4MDYzODgwMDAwMDAw\n'), (u'sAMAccountName', u'Y3NjaGVpbg==\n'), (u'badPwdCount', u'MA==\n'), (u'accountExpires', u'OTIyMzM3MjAzNjg1NDc3NTgwNw==\n'), (u'displayName', u'Q2hyaXN0aW5hIHNjaGVpbmln\n'), (u'codePage', u'MA==\n'), (u'userAccountControl', u'NTEy\n'), (u'lastLogon', u'MTMxOTU0NDE0 NTAyOTgwODcw\n'), (u'sn', u'c2NoZWluaWc=\n'), (u'lastLogoff', u'MA==\n'), (u'lastLogonTimestamp', u'MTMxOTU0NDE0NTAyOTgwODcw\n'), (u'givenName', u'Q2hyaXN0aW5h\n'), (u'mail', u'Y2hyaXMtc2NoZWluQHNjaGVpbi5tZQ==\n')]' 28.06.2019 13:45:44.876 LDAP (INFO ): sync_to_ucs: old_s4_object: {'primaryGroupID': ['513'], 'logonCount': ['1'], 'cn': ['cschein'], 'countryCode': ['0'], 'objectClass': ['top', 'person', 'organizationalPerson', 'user'], 'userPrincipalName': ['cschein@SCHEIN.ME'], 'lastLogonTimestamp': ['131954414502980870'], 'instanceType': ['4'], 'distinguishedName': ['CN=cschein,CN=Users,DC=schein,DC=me'], 'lastLogon': ['131954414502980870'], 'objectSid': ['S-1-5-21-1965273560-2518893881-2166918580-54128'], 'whenCreated': ['20181128003437.0Z'], 'uSNCreated': ['3791'], 'mail': ['chris-schein@schein.me'], 'lockoutTime': ['0'], 'badPasswordTime': ['0'], 'pwdLastSet': ['131828063880000000'], 'sAMAccountName': ['cschein'], 'objectCategory': ['CN=Person,CN=Schema,CN=Configuration,DC=schein,DC=me'], 'objectGUID': ['+\xc2\xad<\xc2\x92\xc2\xb6B\xc3\x8aL\xc2\x97\xc3\x82\xc2\x9d\xc2\xbb\xc2\x9a\xc2\x84\x19u'], 'whenChanged': ['20190628114422.0Z'], 'badPwdCount': ['0'], 'accountExpires': ['9223372036854775807'], 'displayName': ['Christina scheinig'], 'name': ['cschein'], 'codePage': ['0'], 'userAccountControl': ['512'], 'sAMAccountType': ['805306368'], 'uSNChanged': ['4620'], 'sn': ['scheinig'], 'givenName': ['Christina'], 'lastLogoff': ['0']} 28.06.2019 13:45:44.876 LDAP (INFO ): sync_to_ucs: new_s4_object: {'primaryGroupID': [u'513'], 'logonCount': [u'1'], 'cn': [u'cschein'], 'countryCode': [u'0'], 'objectClass': [u'top', u'person', u'organizationalPerson', u'user'], 'userPrincipalName': [u'cschein@SCHEIN.ME'], 'lastLogonTimestamp': [u'131954414502980870'], 'instanceType': [u'4'], 'distinguishedName': [u'CN=cschein,CN=Users,DC=schein,DC=me'], 'lastLogon': [u'131954414502980870'], 'objectSid': [u'S-1-5-21-1965273560-2518893881-2166918580-54128'], 'whenCreated': [u'20181128003437.0Z'], 'uSNCreated': [u'3791'], 'mail': [u'chris-schein@schein.me'], 'lockoutTime': [u'0'], 'badPasswordTime': [u'0'], 'pwdLastSet': [u'131828063880000000'], 'sAMAccountName': [u'cschein'], 'objectCategory': [u'CN=Person,CN=Schema,CN=Configuration,DC=schein,DC=me'], 'objectGUID': [u'+\xad<\x92\xb6B\xcaL\x97\xc2\x9d\xbb\x9a\x84\x19u'], 'whenChanged': [u'20190628114447.0Z'], 'badPwdCount': [u'0'], 'accountExpires': [u'131858460000000000'], 'displayName': [u'Christina scheinig'], 'name': [u'cschein'], 'memberOf': [u'CN=Domain Users sun,CN=groups,OU=sun,DC=schein,DC=me'], 'codePage': [u'0'], 'userAccountControl': [u'512'], 'sAMAccountType': [u'805306368'], 'uSNChanged': [u'4622'], 'sn': [u'scheinig'], 'givenName': [u'Christina'], 'lastLogoff': [u'0']} 28.06.2019 13:45:44.876 LDAP (INFO ): The following attributes have been changed: ['whenChanged', 'accountExpires', 'memberOf', 'uSNChanged'] 28.06.2019 13:45:44.877 LDAP (INFO ): sync_to_ucs: using existing target object type: users/user 28.06.2019 13:45:44.880 LDAP (INFO ): __set_values: object: {'dn': u'uid=cschein,cn=users,dc=schein,dc=me', 'attributes': {'primaryGroupID': [u'513'], 'logonCoun t': [u'1'], 'cn': [u'cschein'], 'countryCode': [u'0'], 'objectClass': [u'top', u'person', u'organizationalPerson', u'user'], 'userPrincipalName': [u'cschein@SCHEIN.ME'], 'lastLogonTimestamp': [u'131954414502980870'], 'instanceType': [u'4'], 'uid': [u'cschein'], 'distinguishedName': [u'CN=cschein,CN=Users,DC=schein,DC=me'], 'lastLogon': [u'131954414502980870'], 'objectSid': [u'S-1-5-21-1965273560-2518893881-2166918580-54128'], 'whenCreated': [u'20181128003437.0Z'], 'uSNCreated': [u'3791'], 'mail': [u'chris-schein@schein.me'], 'lockoutTime': [u'0'], 'badPasswordTime': [u'0'], 'pwdLastSet': [u'131828063880000000'], 'sAMAccountName': [u'cschein'], 'objectCategory': [u'CN=Person,CN=Schema,CN=Configuration,DC=schein,DC=me'], 'objectGUID': [u'+\xad<\x92\xb6B\xcaL\x97\xc2\x9d\xbb\x9a\x84\x19u'], 'whenChanged': [u'20190628114447.0Z'], 'badPwdCount': [u'0'], 'accountExpires': [u'131858460000000000'], 'mailPrimaryAddress': [u'chris-schein@schein.me'], 'displayName': [u'Christina scheinig'], 'name': [u'cschein'], 'memberOf': [u'CN=Domain Users sun,CN=groups,OU=sun,DC=schein,DC=me'], 'codePage': [u'0'], 'userAccountControl': [u'512'], 'sAMAccountType': [u'805306368'], 'uSNChanged': [u'4622'], 'sn': [u'scheinig'], 'givenName': [u'Christina'], 'lastLogoff': [u'0']}, 'changed_attributes': ['whenChanged', 'accountExpires', 'memberOf', 'uSNChanged'], 'modtype': 'modify', 'old_s4_object': {'primaryGroupID': ['513'], 'logonCount': ['1'], 'cn': ['cschein'], 'countryCode': ['0'], 'objectClass': ['top', 'person', 'organizationalPerson', 'user'], 'userPrincipalName': ['cschein@SCHEIN.ME'], 'lastLogonTimestamp': ['131954414502980870'], 'instanceType': ['4'], 'distinguishedName': ['CN=cschein,CN=Users,DC=schein,DC=me'], 'lastLogon': ['131954414502980870'], 'objectSid': ['S-1-5-21-1965273560-2518893881-2166918580-54128'], 'whenCreated': ['20181128003437.0Z'], 'uSNCreated': ['3791'], 'mail': ['chris-schein@schein.me'], 'lockoutTime': ['0'], 'badPasswordTime': ['0'], 'pwdLastSet': ['131828063880000000'], 'sAMAccountName': ['cschein'], 'objectCategory': ['CN=Person,CN=Schema,CN=Configuration,DC=schein,DC=me'], 'objectGUID': ['+\xc2\xad<\xc2\x92\xc2\xb6B\xc3\x8aL\xc2\x97\xc3\x82\xc2\x9d\xc2\xbb\xc2\x9a\xc2\x84\x19u'], 'whenChanged': ['20190628114422.0Z'], 'badPwdCount': ['0'], 'accountExpires': ['9223372036854775807'], 'displayName': ['Christina scheinig'], 'name': ['cschein'], 'codePage': ['0'], 'userAccountControl': ['512'], 'sAMAccountType': ['805306368'], 'uSNChanged': ['4620'], 'sn': ['scheinig'], 'givenName': ['Christina'], 'lastLogoff': ['0']}} 28.06.2019 13:45:44.880 LDAP (INFO ): __set_values: Skip: givenName 28.06.2019 13:45:44.881 LDAP (INFO ): __set_values: Skip: displayName 28.06.2019 13:45:44.881 LDAP (INFO ): __set_values: Skip: sAMAccountName 28.06.2019 13:45:44.881 LDAP (INFO ): __set_values: Skip: sn 28.06.2019 13:45:44.881 LDAP (INFO ): __set_values: mapping for attribute: description 28.06.2019 13:45:44.881 LDAP (INFO ): __set_values: Skip: description 28.06.2019 13:45:44.881 LDAP (INFO ): __set_values: mapping for attribute: street 28.06.2019 13:45:44.882 LDAP (INFO ): __set_values: Skip: streetAddress 28.06.2019 13:45:44.882 LDAP (INFO ): __set_values: mapping for attribute: postcode 28.06.2019 13:45:44.882 LDAP (INFO ): __set_values: Skip: postalCode 28.06.2019 13:45:44.882 LDAP (INFO ): __set_values: mapping for attribute: scriptpath 28.06.2019 13:45:44.882 LDAP (INFO ): __set_values: Skip: scriptPath 28.06.2019 13:45:44.882 LDAP (INFO ): __set_values: mapping for attribute: sambaWorkstations 28.06.2019 13:45:44.883 LDAP (INFO ): __set_values: Skip: userWorkstations 28.06.2019 13:45:44.883 LDAP (INFO ): __set_values: mapping for attribute: pager 28.06.2019 13:45:44.883 LDAP (INFO ): __set_values: Skip: pager 28.06.2019 13:45:44.883 LDAP (INFO ): __set_values: mapping for attribute: homePhone 28.06.2019 13:45:44.883 LDAP (INFO ): __set_values: Skip: homePhone 28.06.2019 13:45:44.883 LDAP (INFO ): __set_values: mapping for attribute: mobilePhone 28.06.2019 13:45:44.884 LDAP (INFO ): __set_values: Skip: mobile 28.06.2019 13:45:44.884 LDAP (INFO ): __set_values: mapping for attribute: telephoneNumber 28.06.2019 13:45:44.884 LDAP (INFO ): __set_values: Skip: telephoneNumber 28.06.2019 13:45:44.884 LDAP (INFO ): __set_values: mapping for attribute: city 28.06.2019 13:45:44.884 LDAP (INFO ): __set_values: Skip: l 28.06.2019 13:45:44.885 LDAP (INFO ): __set_values: mapping for attribute: mailPrimaryAddress 28.06.2019 13:45:44.885 LDAP (INFO ): __set_values: Skip: mail 28.06.2019 13:45:44.885 LDAP (INFO ): __set_values: mapping for attribute: homeDrive 28.06.2019 13:45:44.885 LDAP (INFO ): __set_values: Skip: homeDrive 28.06.2019 13:45:44.885 LDAP (INFO ): __set_values: mapping for attribute: organisation 28.06.2019 13:45:44.885 LDAP (INFO ): __set_values: Skip: company 28.06.2019 13:45:44.886 LDAP (INFO ): __set_values: mapping for attribute: homeDirectory 28.06.2019 13:45:44.886 LDAP (INFO ): __set_values: Skip: homeDirectory 28.06.2019 13:45:44.886 LDAP (INFO ): __set_values: mapping for attribute: profilepath 28.06.2019 13:45:44.886 LDAP (INFO ): __set_values: Skip: profilePath 28.06.2019 13:45:44.901 LDAP (ERROR ): Unknown Exception during sync_to_ucs 28.06.2019 13:45:44.901 LDAP (ERROR ): Traceback (most recent call last): File "/usr/lib/python2.7/dist-packages/univention/s4connector/__init__.py", line 1565, in sync_to_ucs result = self.modify_in_ucs(property_type, object, module, position) File "/usr/lib/python2.7/dist-packages/univention/s4connector/__init__.py", line 1316, in modify_in_ucs res = ucs_object.modify(serverctrls=serverctrls, response=response) File "/usr/lib/pymodules/python2.7/univention/admin/handlers/users/user.py", line 1396, in modify return super(object, self).modify(*args, **kwargs) File "/usr/lib/pymodules/python2.7/univention/admin/handlers/__init__.py", line 642, in modify dn = self._modify(modify_childs, ignore_license=ignore_license, response=response) File "/usr/lib/pymodules/python2.7/univention/admin/handlers/__init__.py", line 1312, in _modify self.dn = self.lo.modify(self.dn, ml, ignore_license=ignore_license, serverctrls=serverctrls, response=response) File "/usr/lib/pymodules/python2.7/univention/admin/uldap.py", line 891, in modify raise univention.admin.uexceptions.permissionDenied permissionDenied