Bug 53838 - 52_s4connector/261read_ad_umlaut_user failed - invalid password rejected by S4C?
52_s4connector/261read_ad_umlaut_user failed - invalid password rejected by S4C?
Status: NEW
Product: UCS Test
Classification: Unclassified
Component: S4 Connector
unspecified
Other Linux
: P5 normal with 2 votes (vote)
: ---
Assigned To: Samba maintainers
:
: 50422 (view as bug list)
Depends on:
Blocks:
  Show dependency treegraph
 
Reported: 2021-09-25 09:17 CEST by Philipp Hahn
Modified: 2022-12-25 15:14 CET (History)
1 user (show)

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


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Philipp Hahn univentionstaff 2021-09-25 09:17:39 CEST
52_s4connector.261read_ad_umlaut_user.master091c failed


<https://jenkins.knut.univention.de:8181/job/UCS-5.0/job/UCS-5.0-0/job/S4Connector/296/cfg=master-only-released-errata-s4connector/testReport/junit/52_s4connector/261read_ad_umlaut_user/master091c/>

univentionService: S4 Connector
info 2021-09-25 03:33:08	 Setting S4 connector 'connector' to read-mode
Setting connector/s4/mapping/syncmode
info 2021-09-25 03:33:10	 User äcbmodizkö created
info 2021-09-25 03:33:10	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:11	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:11	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:12	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:12	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:13	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:13	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:13	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL modified
info 2021-09-25 03:33:14	 Waiting for full synchronisation (sleeping for 16 seconds)
info 2021-09-25 03:33:14	 Hint: You might want to decrease this value during debugging of the tests
info 2021-09-25 03:33:30	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "sAMAccountName" == "äcbmodizkö" ??
info 2021-09-25 03:33:30	 Yes
info 2021-09-25 03:33:30	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "givenName" == "ütkusdizpß" ??
info 2021-09-25 03:33:31	 Yes
info 2021-09-25 03:33:31	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "sn" == "öovbrdiznä" ??
info 2021-09-25 03:33:31	 Yes
info 2021-09-25 03:33:31	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "description" == "ßrlhedizrü" ??
info 2021-09-25 03:33:32	 Yes
info 2021-09-25 03:33:32	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "streetAddress" == "äguiudiztö" ??
info 2021-09-25 03:33:32	 Yes
info 2021-09-25 03:33:32	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "l" == "önnirdizvä" ??
info 2021-09-25 03:33:33	 Yes
info 2021-09-25 03:33:33	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "postalCode" == "üolcxdizxß" ??
info 2021-09-25 03:33:33	 Yes
info 2021-09-25 03:33:33	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "profilePath" == "ßhxurdizzü" ??
info 2021-09-25 03:33:33	 Yes
info 2021-09-25 03:33:33	 CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL: "scriptPath" == "ävnzzdjabö" ??
info 2021-09-25 03:33:34	 Yes
info 2021-09-25 03:33:34	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *description: ' | sed 's/^ *description: //'
info 2021-09-25 03:33:34	 Value of "description" is "", expected "ßrlhedizrü"
error 2021-09-25 03:33:34	 Expected operation to succeed, but it failed
error 2021-09-25 03:33:34	 **************** Test failed above this line (110) ****************
info 2021-09-25 03:33:34	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *username: ' | sed 's/^ *username: //'
info 2021-09-25 03:33:34	 Value of "username" is "", expected "äcbmodizkö"
error 2021-09-25 03:33:34	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:34	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *firstname: ' | sed 's/^ *firstname: //'
info 2021-09-25 03:33:34	 Value of "firstname" is "", expected "ütkusdizpß"
error 2021-09-25 03:33:34	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:34	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *lastname: ' | sed 's/^ *lastname: //'
info 2021-09-25 03:33:34	 Value of "lastname" is "", expected "öovbrdiznä"
error 2021-09-25 03:33:34	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:34	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *street: ' | sed 's/^ *street: //'
info 2021-09-25 03:33:35	 Value of "street" is "", expected "äguiudiztö"
error 2021-09-25 03:33:35	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:35	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *city: ' | sed 's/^ *city: //'
info 2021-09-25 03:33:35	 Value of "city" is "", expected "önnirdizvä"
error 2021-09-25 03:33:35	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:35	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *postcode: ' | sed 's/^ *postcode: //'
info 2021-09-25 03:33:35	 Value of "postcode" is "", expected "üolcxdizxß"
error 2021-09-25 03:33:35	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:35	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *profilepath: ' | sed 's/^ *profilepath: //'
info 2021-09-25 03:33:35	 Value of "profilepath" is "", expected "ßhxurdizzü"
error 2021-09-25 03:33:35	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:35	 EXECUTING: udm-test 'users/user' list --filter "uid=äcbmodizkö" | egrep '^ *scriptpath: ' | sed 's/^ *scriptpath: //'
info 2021-09-25 03:33:35	 Value of "scriptpath" is "", expected "ävnzzdjabö"
error 2021-09-25 03:33:35	 *** Check failed (110), but this might be caused by the error above ***
info 2021-09-25 03:33:35	 Recursively deleting CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL
Deleted 1 records
info 2021-09-25 03:33:36	 Waiting for full synchronisation (sleeping for 16 seconds)
info 2021-09-25 03:33:36	 Hint: You might want to decrease this value during debugging of the tests
info 2021-09-25 03:33:52	 EXECUTING: udm-test 'users/user' list | egrep '^DN: uid=äcbmodizkö,cn=users,dc=AutoTest091c,dc=local$'
info 2021-09-25 03:33:52	 users/user object äcbmodizkö does not exist
info 2021-09-25 03:33:53	 Object CN=äcbmodizkö,CN=users,DC=AUTOTEST091C,DC=LOCAL doesn't exist
info 2021-09-25 03:33:53	 Setting S4 connector 'connector' to sync-mode
Setting connector/s4/mapping/syncmode





<https://jenkins.knut.univention.de:8181/job/UCS-5.0/job/UCS-5.0-0/job/S4Connector/cfg=master-only-released-errata-s4connector/ws/test/connector-s4.log>

25.09.21 03:33:09.481  DEBUG_INIT
25.09.2021 03:33:09.526 LDAP        (PROCESS): Building internal group membership cache
25.09.2021 03:33:09.545 LDAP        (PROCESS): Internal group membership cache was created
25.09.2021 03:33:14.784 LDAP        (PROCESS): sync AD > UCS: [          user] [       add] 'uid=äcbmodizkö,CN=Users,dc=AutoTest091c,dc=local'
25.09.2021 03:33:14.801 LDAP        (WARNING): __set_values: The attributes for unixhome have not been removed as it represents a mandatory attribute
25.09.2021 03:33:14.802 LDAP        (WARNING): __set_values: The attributes for uidNumber have not been removed as it represents a mandatory attribute
25.09.2021 03:33:14.840 LDAP        (ERROR  ): Unknown Exception during sync_to_ucs
25.09.2021 03:33:14.843 LDAP        (ERROR  ): Traceback (most recent call last):
  File "/usr/lib/python3/dist-packages/univention/s4connector/__init__.py", line 1483, in sync_to_ucs
    result = self.add_in_ucs(property_type, object, module, position)
  File "/usr/lib/python3/dist-packages/univention/s4connector/__init__.py", line 1203, in add_in_ucs
    res = ucs_object.create(serverctrls=serverctrls, response=response)
  File "/usr/lib/python3/dist-packages/univention/admin/handlers/__init__.py", line 543, in create
    dn = self._create(response=response, serverctrls=serverctrls)
  File "/usr/lib/python3/dist-packages/univention/admin/handlers/__init__.py", line 1255, in _create
    al.extend(self._ldap_modlist())
  File "/usr/lib/python3/dist-packages/univention/admin/handlers/users/user.py", line 1755, in _ldap_modlist
    ml = self._modlist_posix_password(ml)
  File "/usr/lib/python3/dist-packages/univention/admin/handlers/users/user.py", line 1988, in _modlist_posix_password
    raise univention.admin.uexceptions.valueError(_('Invalid password.'), property='password')
univention.admin.uexceptions.valueError: Invalid password.

25.09.2021 03:33:35.915 LDAP        (PROCESS): sync AD > UCS: [          user] [    delete] 'uid=äcbmodizkö,CN=Users,dc=AutoTest091c,dc=local'
25.09.2021 03:33:35.916 LDAP        (PROCESS): sync AD > UCS: [          user] [    delete] 'uid=äcbmodizkö,CN=Users,dc=AutoTest091c,dc=local': ignore, object to delete doesn't exists
Comment 1 Florian Best univentionstaff 2022-12-25 15:14:00 CET
*** Bug 50422 has been marked as a duplicate of this bug. ***