The nightly test test_extdom_plugin is failing in [testing_ipa-4.6] Nightly PR #1153 with an error
test_extdom_plugin
def test_extdom_plugin(self): """Extdom plugin should not return error (32)/'No such object' Regression test for https://pagure.io/freeipa/issue/8044 If there is a timeout during a request to SSSD the extdom plugin should not return error 'No such object' and the existing user should not be added to negative cache on the client. """ extdom_dn = DN( ('cn', 'ipa_extdom_extop'), ('cn', 'plugins'), ('cn', 'config') ) client = self.clients[0] tasks.backup_file(self.master, paths.SSSD_CONF) log_file = '{0}/sssd_{1}.log'.format(paths.VAR_LOG_SSSD_DIR, client.domain.name) logsize = len(client.get_file_contents(log_file)) res = self.master.run_command(['pidof', 'sssd_be']) pid = res.stdout_text.strip() test_id = 'id testuser@%s' % self.ad_domain client.run_command(test_id) conn = self.master.ldap_connect() entry = conn.get_entry(extdom_dn) # pylint: disable=no-member orig_extdom_timeout = entry.single_value.get('ipaextdommaxnsstimeout') # set the extdom plugin timeout to 1s (1000) entry.single_value['ipaextdommaxnsstimeout'] = 1000 conn.update_entry(entry) # pylint: disable=no-member self.master.run_command(['ipactl', 'restart']) with tasks.remote_sssd_config(self.master) as sssd_conf: sssd_conf.edit_domain(self.master.domain, 'timeout', '999999') remove_cache = 'sss_cache -E' self.master.run_command(remove_cache) client.run_command(remove_cache) try: # stop sssd_be, needed to simulate a timeout in the extdom plugin. stop_sssdbe = self.master.run_command('kill -STOP %s' % pid) client.run_command(test_id) error = 'ldap_extended_operation result: No such object(32)' sssd_log2 = client.get_file_contents(log_file)[logsize:] > assert error.encode() not in sssd_log2 E assert b'ldap_extended_operation result: No such object(32)' not in b"(Mon Sep 6 14:52:43 2021) [sssd[be[ipa.test]]] [dp_attach_req] (0x0400): DP Request [Subdomains #4]: New request. F...moved.\n(Mon Sep 6 14:53:33 2021) [sssd[be[ipa.test]]] [dp_req_destructor] (0x0400): Number of active DP request: 0\n" E + where b'ldap_extended_operation result: No such object(32)' = <built-in method encode of str object at 0x7f7664cc2780>() E + where <built-in method encode of str object at 0x7f7664cc2780> = 'ldap_extended_operation result: No such object(32)'.encode test_integration/test_trust.py:301: AssertionError
Full report
Current scenario:
The log starting point is obtained too early IMO, should be probably done just before step 10.
Metadata Update from @sorlov: - Issue assigned to sorlov
I have a strong feeling that this failure is related to https://github.com/freeipa/freeipa/pull/5991
Need to find out why it is affecting only ipa-4-6. The code of test_extdom_plugin() is identical in master and ipa-4-6 branches
test_extdom_plugin()
Some observations: - test is failing only for ipa-4-6 branch - Backport for PR5991 was merged into ipa-4-6 on 2.9.2021 - The test passed on 29.08.2021 and started failing since 5.9.2021 - Test fails in 100% of runs (checked with 9 runs)
Failure observed in [testing_ipa-4.6] Nightly PR #1168 , report
master:
ipa-4-6:
ipa-4-9:
Metadata Update from @sorlov: - Issue close_status updated to: fixed - Issue status updated to: Closed (was: Open)