*** BEGIN *** ['/bin/bash', '63uid-to-sid_sid-to-uid_mapping'] ***
*** 51_samba4/63uid-to-sid_sid-to-uid_mapping *** test uid-to-sid and sid-to-uid mapping ***
*** START TIME: 2021-09-10 04:47:19 ***
info 2021-09-10 04:47:20	 create user q7snllsb using udm-test users/user create --position=cn=users,dc=autotest095,dc=local --set username=q7snllsb --set firstname=Max --set lastname=Muster --set organisation=firma.de_GmbH --set password=univention --set mailPrimaryAddress=rj8ku8uhhxeohi3jan3z@autotest095.local --set uidNumber=300005
Object created: uid=q7snllsb,cn=users,dc=autotest095,dc=local
debug 2021-09-10 04:47:21	 Waiting for replication...
CRITICAL: no change of listener transaction id for last 0 checks (nid=10351 lid=10346)
OK: replication complete (nid=10351 lid=10351)
info 2021-09-10 04:47:23	 replication complete.
Waiting for S4-Connector and LDAP replication of domain sambaSID for user q7snllsb (current: S-1-4-300005)...
Waiting for DRS replication of domain sambaSID for user q7snllsb...S4-Connector and LDAP replication of domain sambaSID took 7 seconds
++ ldap_get_attribute uid=q7snllsb,cn=users,dc=autotest095,dc=local sambaSID
++ local dn=uid=q7snllsb,cn=users,dc=autotest095,dc=local
++ local attribute=sambaSID
++ local encoding=UTF-8
++ python3 -c '
import sys
sys.path.append('\''/usr/share/ucs-test/lib'\'')
import ldap_glue
ldapconnection = ldap_glue.LDAPConnection()
for value in ldapconnection.get_attribute('\''uid=q7snllsb,cn=users,dc=autotest095,dc=local'\'', '\''sambaSID'\''):
	print(value.decode('\''UTF-8'\''))
sys.exit(42)
'
Traceback (most recent call last):
  File "<string>", line 5, in <module>
  File "/usr/share/ucs-test/lib/ldap_glue.py", line 47, in __init__
    self.connect(no_starttls)
  File "/usr/share/ucs-test/lib/ldap_glue.py", line 58, in connect
    with open(self.pw_file, 'r') as fp:
FileNotFoundError: [Errno 2] No such file or directory: '/etc/ldap.secret'
++ local rc=1
++ '[' 1 -eq 42 ']'
++ scriptlet_error ldap_get_attribute
++ local function=ldap_get_attribute
++ error 'Python scriptlet in function ldap_get_attribute terminated unexpectedly'
+++ date '+%Y-%m-%d %H:%M:%S\t'
++ echo -e 'error 2021-09-10 04:47:30\t Python scriptlet in function ldap_get_attribute terminated unexpectedly'
error 2021-09-10 04:47:30	 Python scriptlet in function ldap_get_attribute terminated unexpectedly
++ info 'Probably there was an uncaught exception, that should be visible above'
++ '[' 4 -ge 2 ']'
+++ date '+%Y-%m-%d %H:%M:%S\t'
++ echo -e 'info 2021-09-10 04:47:30\t Probably there was an uncaught exception, that should be visible above'
info 2021-09-10 04:47:30	 Probably there was an uncaught exception, that should be visible above
++ return 2
+ SID_FROM_LDAP=
++ wbinfo --uid-to-sid=300005
+ SID=S-1-5-21-3859163466-1272886956-3474861177-2165
+ '[' '' '!=' S-1-5-21-3859163466-1272886956-3474861177-2165 ']'
+ fail_test 2 'wbinfo uidNumber to sid usermapping failed'
+ local errorcode=110
+ case "$1" in
+ errorcode=2
+ shift
+ false
+ ALREADY_FAILED=true
+ RETVAL=2
+ '[' -n 'wbinfo uidNumber to sid usermapping failed' ']'
+ error 'wbinfo uidNumber to sid usermapping failed'
++ date '+%Y-%m-%d %H:%M:%S\t'
+ echo -e 'error 2021-09-10 04:47:30\t wbinfo uidNumber to sid usermapping failed'
error 2021-09-10 04:47:30	 wbinfo uidNumber to sid usermapping failed
+ error '**************** Test failed above this line (2) ****************'
++ date '+%Y-%m-%d %H:%M:%S\t'
+ echo -e 'error 2021-09-10 04:47:30\t **************** Test failed above this line (2) ****************'
error 2021-09-10 04:47:30	 **************** Test failed above this line (2) ****************
++ wbinfo --sid-to-uid=S-1-5-21-3859163466-1272886956-3474861177-2165
+ WBINFO_UID=300005
+ '[' 300005 '!=' 300005 ']'
+ set +x
info 2021-09-10 04:47:30	 remove user q7snllsb
Object removed: uid=q7snllsb,cn=users,dc=autotest095,dc=local
debug 2021-09-10 04:47:31	 user q7snllsb removed
info 2021-09-10 04:47:31	 checking whether the user q7snllsb is really removed
debug 2021-09-10 04:47:31	 user q7snllsb does not exist
debug 2021-09-10 04:47:31	 Waiting for replication...
OK: replication complete (nid=10356 lid=10356)
info 2021-09-10 04:47:31	 replication complete.
debug 2021-09-10 04:47:31	 Waiting for postrun...
*** END TIME: 2021-09-10 04:47:49 ***
*** TEST DURATION (H:MM:SS.ms): 0:00:29.620787 ***
*** END *** 0 ***