Bug 2424132 - Upgrade from freeipa-4.12.5-3 and 389-ds-base-3.1.3-10 to latest rawhide fails
Summary: Upgrade from freeipa-4.12.5-3 and 389-ds-base-3.1.3-10 to latest rawhide fails
Keywords:
Status: CLOSED ERRATA
Alias: None
Product: Fedora
Classification: Fedora
Component: 389-ds-base
Version: rawhide
Hardware: Unspecified
OS: Linux
unspecified
medium
Target Milestone: ---
Assignee: Viktor Ashirov
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
: 2424526 (view as bug list)
Depends On:
Blocks: BetaBlocker, F44BetaBlocker
TreeView+ depends on / blocked
 
Reported: 2025-12-20 20:02 UTC by Jan Pazdziora
Modified: 2026-01-12 13:47 UTC (History)
14 users (show)

Fixed In Version: 389-ds-base-3.2.0-5.fc44
Clone Of:
Environment:
Last Closed: 2026-01-12 13:47:29 UTC
Type: ---
Embargoed:
fedora-admin-xmlrpc: mirror+


Attachments (Terms of Use)


Links
System ID Private Priority Status Summary Last Updated
Github 389ds 389-ds-base issues 7172 0 None open Index ordering mismatch after upgrade 2026-01-08 09:20:23 UTC
Github 389ds 389-ds-base pull 7173 0 None open Issue 7172 - Index ordering mismatch after upgrade 2026-01-08 09:19:54 UTC
Github 389ds 389-ds-base pull 7180 0 None open Issue 7172 - (2nd) Index ordering mismatch after upgrade 2026-01-10 18:03:34 UTC
Red Hat Issue Tracker FC-2897 0 None None None 2026-01-07 07:57:43 UTC

Description Jan Pazdziora 2025-12-20 20:02:27 UTC
In the FreeIPA container we started to see failures when upgrading from Fedora 43 to rawhide: https://github.com/freeipa/freeipa-container/issues/709

The failures we saw there were related to replica failing to initiate properly with error

Error: r] RuntimeError: Certificate issuance failed (CA_UNREACHABLE: Server at https://ipa.example.test/ipa/json failed request, will retry: 4301 (Certificate operation cannot be completed: Server Internal Error: Unable to add certificate record: Record already exists: Already exists).)

plus we also saw

2025-12-19 17:06:00 [ajp-nio-0:0:0:0:0:0:0:1-8009-exec-9] INFO: CertProcessor: Submitting certificate request to caIPAserviceCert profile
2025-12-19 17:06:00 [ajp-nio-0:0:0:0:0:0:0:1-8009-exec-9] INFO: LDAPSession: Adding cn=1,ou=ca, ou=requests,o=ipaca
2025-12-19 17:06:00 [ajp-nio-0:0:0:0:0:0:0:1-8009-exec-9] SEVERE: RequestRepository: Record already exists: Already exists
Record already exists: Already exists

and

Dec 19 17:05:49 ipa.example.test ns-slapd[4264]: [19/Dec/2025:17:05:49.059466334 +0000] - ERR - NSMMReplicationPlugin - acquire_replica - agmt="cn=meToreplica.example.test" (replica:389): Un
able to acquire replica: permission denied. The bind dn "" does not have permission to supply replication updates to the replica. Will retry later.
Dec 19 17:05:52 ipa.example.test ns-slapd[4264]: [19/Dec/2025:17:05:52.066099098 +0000] - WARN - NSMMReplicationPlugin - acquire_replica - agmt="cn=meToreplica.example.test" (replica:389): U
nable to receive the response for a startReplication extended operation to consumer (Can't contact LDAP server). Will retry later.

In the container there is not rpm upgrade happening since the container just gets run with new packages installed in the new image. We try to emulate the rpm upgrade operation and we do run ipa-server-upgrade when we see that the image has changed but I understand the environment is different in the container.

To reproduce on the host, we'd ideally want to debug upgrade from Fedora 43 with freeipa-4.12.5-3 and 389-ds-base-3.1.3-10 to rawhide. But upgrades across Fedora versions are hard, they take a lot of network bandwidth and time, so below I show upgrade of rawhide with packages from koji matching in version those in Fedora 43 where we observed the problem, to latest rawhide.

Since after the upgrade the ipa.service is shown failed with errors /var/log/ipaupgrade.log, it looks there's something that needs to be investigated and fixed in that upgrade path, and hopefully it might contribute to fixing the containerized use-case as well.


Reproducible: Always

Steps to Reproduce:

1. Have Fedora rawhide VM with hostname ipa.example.test.
2. dnf upgrade -y --setopt=install_weak_deps=False \
        && dnf install -y --setopt=install_weak_deps=False \
        https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.1.3/10.fc44/$( uname -m )/389-ds-base-3.1.3-10.fc44.$( uname -m ).rpm \
        https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.1.3/10.fc44/$( uname -m )/389-ds-base-libs-3.1.3-10.fc44.$( uname -m ).rpm \
        https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.1.3/10.fc44/$( uname -m )/389-ds-base-robdb-libs-3.1.3-10.fc44.$( uname -m ).rpm \
        https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.1.3/10.fc44/noarch/python3-lib389-3.1.3-10.fc44.noarch.rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/$( uname -m )/freeipa-client-4.12.5-3.fc44.$( uname -m ).rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/noarch/freeipa-client-common-4.12.5-3.fc44.noarch.rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/$( uname -m )/freeipa-client-epn-4.12.5-3.fc44.$( uname -m ).rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/noarch/freeipa-common-4.12.5-3.fc44.noarch.rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/$( uname -m )/freeipa-server-4.12.5-3.fc44.$( uname -m ).rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/noarch/freeipa-server-common-4.12.5-3.fc44.noarch.rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/noarch/freeipa-server-dns-4.12.5-3.fc44.noarch.rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/$( uname -m )/freeipa-server-trust-ad-4.12.5-3.fc44.$( uname -m ).rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/noarch/python3-ipaclient-4.12.5-3.fc44.noarch.rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/noarch/python3-ipalib-4.12.5-3.fc44.noarch.rpm \
        https://kojipkgs.fedoraproject.org//packages/freeipa/4.12.5/3.fc44/noarch/python3-ipaserver-4.12.5-3.fc44.noarch.rpm
3. ipa-server-install -U -r EXAMPLE.TEST -p Secret123 -a Secret123 --no-ntp --setup-dns --forwarder=8.8.8.8
4. dnf upgrade -y
5. systemctl is-failed

Actual Results:

degraded


Expected Results:

running


Additional Information:

[root@ipa ~]# systemctl status ipa.service
× ipa.service - Identity, Policy, Audit
     Loaded: loaded (/usr/lib/systemd/system/ipa.service; enabled; preset: disabled)
    Drop-In: /usr/lib/systemd/system/service.d
             └─10-timeout-abort.conf
     Active: failed (Result: exit-code) since Sat 2025-12-20 19:47:43 UTC; 56s ago
   Duration: 58.056s
 Invocation: 9dbfffb0eb294919b5fa8554ff87f90d
   Main PID: 10700 (code=exited, status=1/FAILURE)
   Mem peak: 288M
        CPU: 8.847s

Dec 20 19:47:42 ipa.example.test ipactl[10700]: IPA server upgrade failed: Inspect /var/log/ipaupgrade.log and run command ipa-server-upgrade manually.
Dec 20 19:47:42 ipa.example.test ipactl[10700]: Unexpected error - see /var/log/ipaupgrade.log for details:
Dec 20 19:47:42 ipa.example.test ipactl[10700]: EmptyResult: no matching entry found
Dec 20 19:47:42 ipa.example.test ipactl[10700]: The ipa-server-upgrade command failed. See /var/log/ipaupgrade.log for more information
Dec 20 19:47:42 ipa.example.test ipactl[10700]: See the upgrade log for more details and/or run /usr/sbin/ipa-server-upgrade again
Dec 20 19:47:42 ipa.example.test ipactl[10700]: Aborting ipactl
Dec 20 19:47:43 ipa.example.test systemd[1]: ipa.service: Main process exited, code=exited, status=1/FAILURE
Dec 20 19:47:43 ipa.example.test systemd[1]: ipa.service: Failed with result 'exit-code'.
Dec 20 19:47:43 ipa.example.test systemd[1]: Failed to start ipa.service - Identity, Policy, Audit.
Dec 20 19:47:43 ipa.example.test systemd[1]: ipa.service: Consumed 8.847s CPU time over 2min 39.322s wall clock time, 288M memory peak.

[root@ipa ~]# tail -120 /var/log/ipaupgrade.log
2025-12-20T19:47:41Z DEBUG raw: ca_is_enabled(version='2.257')
2025-12-20T19:47:41Z DEBUG ca_is_enabled(version='2.257')
2025-12-20T19:47:41Z DEBUG raw: kra_is_enabled(version='2.257')
2025-12-20T19:47:41Z DEBUG kra_is_enabled(version='2.257')
2025-12-20T19:47:41Z DEBUG Cleaning up after pkispawn for the CA subsystem
2025-12-20T19:47:41Z DEBUG Loading StateFile from '/var/lib/ipa/sysrestore/sysrestore.state'
2025-12-20T19:47:41Z DEBUG Loading Index file from '/var/lib/ipa/sysrestore/sysrestore.index'
2025-12-20T19:47:41Z DEBUG Removing /root/.dogtag/pki-tomcat/ca
2025-12-20T19:47:41Z DEBUG Loading StateFile from '/var/lib/ipa/sysrestore/sysrestore.state'
2025-12-20T19:47:41Z INFO dnssec-validation yes
2025-12-20T19:47:41Z INFO [Add missing CA DNS records]
2025-12-20T19:47:41Z DEBUG Loading StateFile from '/var/lib/ipa/sysupgrade/sysupgrade.state'
2025-12-20T19:47:41Z DEBUG raw: dns_is_enabled(version='2.257')
2025-12-20T19:47:41Z DEBUG dns_is_enabled(version='2.257')
2025-12-20T19:47:41Z DEBUG raw: dnsrecord_find('example.test', 'ipa-ca', version='2.257')
2025-12-20T19:47:41Z DEBUG dnsrecord_find(<DNS name example.test.>, 'ipa-ca', structured=False, all=False, raw=False, version='2.257', pkey_only=False)
2025-12-20T19:47:41Z DEBUG Updating DNS system records
2025-12-20T19:47:41Z DEBUG raw: server_find(None, version='2.257', no_members=False, servrole='IPA master')
2025-12-20T19:47:41Z DEBUG server_find(None, all=False, raw=False, version='2.257', no_members=False, pkey_only=False, servrole=('IPA master',))
2025-12-20T19:47:41Z DEBUG raw: server_role_find(None, server_server=None, role_servrole='IPA master', status='enabled', include_master=True, version='2.257')
2025-12-20T19:47:41Z DEBUG server_role_find(None, server_server=None, role_servrole='IPA master', status='enabled', include_master=True, all=False, raw=False, version='2.257')
2025-12-20T19:47:41Z ERROR IPA server upgrade failed: Inspect /var/log/ipaupgrade.log and run command ipa-server-upgrade manually.
2025-12-20T19:47:41Z DEBUG   File "/usr/lib/python3.14/site-packages/ipapython/admintool.py", line 219, in execute
    return_value = self.run()
  File "/usr/lib/python3.14/site-packages/ipaserver/install/ipa_server_upgrade.py", line 54, in run
    server.upgrade()
    ~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 2066, in upgrade
    upgrade_configuration()
    ~~~~~~~~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 1887, in upgrade_configuration
    upgrade_bind(fstore)
    ~~~~~~~~~~~~^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 1482, in upgrade_bind
    add_ca_dns_records(bind)
    ~~~~~~~~~~~~~~~~~~^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 865, in add_ca_dns_records
    bind.update_system_records()
    ~~~~~~~~~~~~~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/bindinstance.py", line 1316, in update_system_records
    system_records = IPASystemRecords(self.api)
  File "/usr/lib/python3.14/site-packages/ipaserver/dns_data_management.py", line 97, in __init__
    self.__init_data(all_servers=all_servers)
    ~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/dns_data_management.py", line 124, in __init_data
    servers = self.api_instance.Command.server_find(**kwargs)
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 477, in __call__
    return self.__do_call(*args, **options)
           ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 544, in __do_call
    ret = self.run(*args, **options)
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 885, in run
    return self.execute(*args, **options)
           ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/baseldap.py", line 2158, in execute
    (filter, base_dn, scope) = callback(
                               ~~~~~~~~^
        self, ldap, filter, attrs_list, base_dn, scope, *args, **options)
        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/server.py", line 407, in pre_callback
    servrole_filter = self._get_enabled_servrole_filter(
        ldap, options['servrole'])
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/server.py", line 354, in _get_enabled_servrole_filter
    enabled_masters = _get_masters_with_enabled_servrole(
        servroles[0])
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/server.py", line 344, in _get_masters_with_enabled_servrole
    role_status = self.api.Command.server_role_find(
                  ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
        server_server=None,
        ^^^^^^^^^^^^^^^^^^^
    ...<2 lines>...
        include_master=True,
        ^^^^^^^^^^^^^^^^^^^^
    )['result']
    ^
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 477, in __call__
    return self.__do_call(*args, **options)
           ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 544, in __do_call
    ret = self.run(*args, **options)
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 885, in run
    return self.execute(*args, **options)
           ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/serverrole.py", line 158, in execute
    role_status = self.obj.backend.server_role_search(
        server_server=server,
        role_servrole=role_name,
        status=status)
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/serverroles.py", line 132, in server_role_search
    role_status = found_role.status(self.api, server=server_server)
  File "/usr/lib/python3.14/site-packages/ipaserver/servroles.py", line 562, in status
    return super(ServiceBasedRole, self).status(
           ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
        api_instance, server=server, attrs_list=('ipaConfigString', 'cn'))
        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/servroles.py", line 222, in status
    self._fill_in_absent_masters(ldap2, api_instance, result))
    ~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/servroles.py", line 175, in _fill_in_absent_masters
    all_masters = ldap2.get_entries(
        search_base,
        filter=search_filter,
        scope=SCOPE_ONELEVEL,
        attrs_list=attrs_list)
  File "/usr/lib/python3.14/site-packages/ipapython/ipaldap.py", line 1473, in get_entries
    entries, truncated = self.find_entries(
                         ~~~~~~~~~~~~~~~~~^
        base_dn=base_dn, scope=scope, filter=filter, attrs_list=attrs_list,
        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
        get_effective_rights=get_effective_rights,
        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
        **kwargs)
        ^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipapython/ipaldap.py", line 1617, in find_entries
    raise errors.EmptyResult(reason='no matching entry found')

2025-12-20T19:47:41Z DEBUG The ipa-server-upgrade command failed, exception: EmptyResult: no matching entry found
2025-12-20T19:47:41Z ERROR Unexpected error - see /var/log/ipaupgrade.log for details:
EmptyResult: no matching entry found
2025-12-20T19:47:41Z ERROR The ipa-server-upgrade command failed. See /var/log/ipaupgrade.log for more information

Comment 1 Jan Pazdziora 2025-12-21 09:52:34 UTC
We also see new and similar "creating replica fails after master got upgraded" failure on Rocky Linux 8 where 389-ds-base got upgraded from 1.4.3.39-15.* to 1.4.3.39-19.*: https://github.com/freeipa/freeipa-container/issues/710.

It is quite strange coincidence that things started to fail on the same day on two OSes that are that far apart.

Is there a common patch which went to both that could help narrow down the investigation?

Comment 2 Alexander Bokovoy 2026-01-07 07:38:04 UTC
This looks the same as https://bugzilla.redhat.com/show_bug.cgi?id=2424526 which already gained BetaBlocker status.

@adelton, do you mind if I'll close this one as a duplicate of the other one?

We need to clone 2424526 upstream and work on it anyway.

Comment 3 Jan Pazdziora 2026-01-07 07:52:54 UTC
Well, https://bugzilla.redhat.com/show_bug.cgi?id=2424526 says "F43 to F44 upgrade works" while here we describe a failure of upgrade from Fedora 43 to rawhide, and even from rawhide to rawhide.

Plus we also note here as additional datapoint that upgrades of Rocky Linux 8 and AlmaLinux 8 (and I assume RHEL 8 as well) started to fail at the same time.

I'm a bit worried worried that some fast bandaid will be done for https://bugzilla.redhat.com/show_bug.cgi?id=2424526 to unblock the Beta without really digging into the root cause and fix.

Comment 4 Alexander Bokovoy 2026-01-07 08:12:03 UTC
I talked to Victor and he noted there is at least one customer case with a similar index-related issue. This would explain the problem appearing in different releases.

Both bugs now moved to 389-ds-base component.

Comment 5 Jan Pazdziora 2026-01-09 07:54:34 UTC
Hello Viktor,

thanks for the active investigation and already having a PR upstream.

Is there a RHEL specific Jira issue as the engineering tracker for that customer case?

Seeing that the parentId patch mentioned as the culprit in the upstream issue https://github.com/389ds/389-ds-base/issues/7172 is in Rocky Linux 8 (https://git.rockylinux.org/staging/rpms/389-ds-base/-/commit/179e7a97665e61b81b6bbfc68b30c3adf95ae51c#1ed7112a87892a56d49cab4c6afc319d06fcd64c) makes me believe that this bugzilla and upstream PR https://github.com/389ds/389-ds-base/pull/7173 might actually be the same as the Rocky Linux 8 and AlmaLinux 8 issue https://github.com/freeipa/freeipa-container/issues/710. So I'd like to be able to link the place where the backport might happen from that FreeIPA container's GitHub issue.

I did

  https://issues.redhat.com/issues/?jql=project %3D RHEL and component %3D 389-ds-base order by created

but neither of those publicly visible issues seems to ring a bell.

Comment 6 Viktor Ashirov 2026-01-09 08:42:33 UTC
Hello Jan,

first of all, thank you for the detailed reproducer!
RHEL downstream work is tracked in https://issues.redhat.com/browse/RHEL-137786. I've changed the visibility of RHEL ticket and you should be able to see it now.

Thanks!

Comment 7 Jan Pazdziora 2026-01-09 08:50:05 UTC
Perfect, thank you.

Comment 8 Viktor Ashirov 2026-01-09 12:01:16 UTC
*** Bug 2424526 has been marked as a duplicate of this bug. ***

Comment 9 Fedora Update System 2026-01-09 18:55:09 UTC
FEDORA-2026-3f562e9007 (389-ds-base-3.2.0-3.fc44) has been submitted as an update to Fedora 44.
https://bodhi.fedoraproject.org/updates/FEDORA-2026-3f562e9007

Comment 10 Fedora Update System 2026-01-09 19:05:14 UTC
FEDORA-2026-54d5a579fe (389-ds-base-3.2.0-4.fc44) has been submitted as an update to Fedora 44.
https://bodhi.fedoraproject.org/updates/FEDORA-2026-54d5a579fe

Comment 11 Jan Pazdziora 2026-01-10 11:21:53 UTC
I tried to take a Fedora rawhide machine with the old packages installed and ipa-server-install run, basically steps 1 - 3 from comment 0.

I then run

# dnf upgrade -y https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.2.0/4.fc44/$( uname -m )/389-ds-base-3.2.0-4.fc44.$( uname -m ).rpm \
                https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.2.0/4.fc44/$( uname -m )/389-ds-base-libs-3.2.0-4.fc44.$( uname -m ).rpm \
                https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.2.0/4.fc44/$( uname -m )/389-ds-base-robdb-libs-3.2.0-4.fc44.$( uname -m ).rpm \
                https://kojipkgs.fedoraproject.org//packages/389-ds-base/3.2.0/4.fc44/noarch/python3-lib389-3.2.0-4.fc44.noarch.rpm
[ ... this passed ... ]
# ipa-server-upgrade

Upgrading IPA:. Estimated time: 1 minute 30 seconds
  [1/11]: stopping directory server
  [2/11]: saving configuration
  [3/11]: disabling listeners
  [4/11]: enabling DS global lock
  [5/11]: disabling Schema Compat
  [6/11]: starting directory server
  [7/11]: updating schema
  [8/11]: upgrading server
  [9/11]: stopping directory server
  [10/11]: restoring configuration
  [11/11]: starting directory server
Done.
Update complete
Upgrading IPA services
Upgrading the configuration of the IPA services
Disabled p11-kit-proxy
[Verifying that root certificate is published]
[Migrate CRL publish directory]
Publish directory already set to new location
[Verifying that KDC configuration is using ipa-kdb backend]
[Fix DS schema file syntax]
[Removing RA cert from DS NSS database]
[Enable sidgen and extdom plugins by default]
[Updating HTTPD service IPA configuration]
[Updating HTTPD service IPA WSGI configuration]
[Moving HTTPD service keytab to gssproxy]
[Removing self-signed CA]
[Removing Dogtag 9 CA]
[Set OpenSSL engine or provider for BIND]
Restarting ipa-dnskeysyncd
[Checking for deprecated KDC configuration files]
[Checking for deprecated backups of Samba configuration files]
dnssec-validation yes
[Add missing CA DNS records]
Updating DNS system records
IPA server upgrade failed: Inspect /var/log/ipaupgrade.log and run command ipa-server-upgrade manually.
Unexpected error - see /var/log/ipaupgrade.log for details:
DatabaseError: Operations error: 
The ipa-server-upgrade command failed. See /var/log/ipaupgrade.log for more information

The /var/log/ipaupgrade.log ends with

2026-01-10T11:16:16Z DEBUG dnsrecord_find(<DNS name example.test.>, 'ipa-ca', structured=False, all=False, raw=False, version='2.254', pkey_only=False)
2026-01-10T11:16:16Z DEBUG Updating DNS system records
2026-01-10T11:16:16Z DEBUG raw: server_find(None, version='2.254', no_members=False, servrole='IPA master')
2026-01-10T11:16:16Z DEBUG server_find(None, all=False, raw=False, version='2.254', no_members=False, pkey_only=False, servrole=('IPA master',))
2026-01-10T11:16:16Z DEBUG raw: server_role_find(None, server_server=None, role_servrole='IPA master', status='enabled', include_master=True, version='2.254')
2026-01-10T11:16:16Z DEBUG server_role_find(None, server_server=None, role_servrole='IPA master', status='enabled', include_master=True, all=False, raw=False, version='2.254')
2026-01-10T11:16:16Z DEBUG raw: topologysuffix_find(None, all=True, raw=True, version='2.254')
2026-01-10T11:16:16Z DEBUG topologysuffix_find(None, all=True, raw=True, version='2.254', pkey_only=False)
2026-01-10T11:16:16Z DEBUG raw: server_role_find(None, server_server='ipa.example.test', status='enabled', include_master=True, version='2.254')
2026-01-10T11:16:16Z DEBUG server_role_find(None, server_server='ipa.example.test', status='enabled', include_master=True, all=False, raw=False, version='2.254')
2026-01-10T11:16:16Z DEBUG raw: dnszone_show(<DNS name example.test.>, version='2.254')
2026-01-10T11:16:16Z DEBUG dnszone_show(<DNS name example.test.>, rights=False, all=False, raw=False, version='2.254')
2026-01-10T11:16:16Z DEBUG raw: dnsrecord_del(<DNS name example.test.>, <DNS name ipa-ca.example.test.>, del_all=True, version='2.254')
2026-01-10T11:16:16Z DEBUG dnsrecord_del(<DNS name example.test.>, <DNS name ipa-ca.example.test.>, del_all=True, structured=False, raw=False, version='2.254')
2026-01-10T11:16:16Z DEBUG raw: dnsrecord_delentry(<DNS name example.test.>, (<DNS name ipa-ca.example.test.>,), version='2.254')
2026-01-10T11:16:16Z DEBUG dnsrecord_delentry(<DNS name example.test.>, (<DNS name ipa-ca.example.test.>,), continue=False, version='2.254')
2026-01-10T11:16:16Z DEBUG Unhandled LDAPError: OPERATIONS_ERROR: {'msgtype': 107, 'msgid': 36, 'result': 1, 'desc': 'Operations error', 'ctrls': []}
2026-01-10T11:16:16Z ERROR IPA server upgrade failed: Inspect /var/log/ipaupgrade.log and run command ipa-server-upgrade manually.
2026-01-10T11:16:16Z DEBUG   File "/usr/lib/python3.14/site-packages/ipapython/admintool.py", line 219, in execute
    return_value = self.run()
  File "/usr/lib/python3.14/site-packages/ipaserver/install/ipa_server_upgrade.py", line 54, in run
    server.upgrade()
    ~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 2083, in upgrade
    upgrade_configuration()
    ~~~~~~~~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 1904, in upgrade_configuration
    upgrade_bind(fstore)
    ~~~~~~~~~~~~^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 1499, in upgrade_bind
    add_ca_dns_records(bind)
    ~~~~~~~~~~~~~~~~~~^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/server/upgrade.py", line 882, in add_ca_dns_records
    bind.update_system_records()
    ~~~~~~~~~~~~~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/install/bindinstance.py", line 1315, in update_system_records
    ) = system_records.update_dns_records()
        ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/dns_data_management.py", line 523, in update_dns_records
    self.update_base_records(),
    ~~~~~~~~~~~~~~~~~~~~~~~~^^
  File "/usr/lib/python3.14/site-packages/ipaserver/dns_data_management.py", line 470, in update_base_records
    self.api_instance.Command.dnsrecord_del(
    ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
        self.domain_abs, r_name, del_all=True)
        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 477, in __call__
    return self.__do_call(*args, **options)
           ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 544, in __do_call
    ret = self.run(*args, **options)
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 885, in run
    return self.execute(*args, **options)
           ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/dns.py", line 3955, in execute
    result = self.obj.methods.delentry(*keys,
                                       version=options['version'])
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 477, in __call__
    return self.__do_call(*args, **options)
           ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 544, in __do_call
    ret = self.run(*args, **options)
  File "/usr/lib/python3.14/site-packages/ipalib/frontend.py", line 885, in run
    return self.execute(*args, **options)
           ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/baseldap.py", line 1690, in execute
    delete_entry(pkey)
    ~~~~~~~~~~~~^^^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/baseldap.py", line 1665, in delete_entry
    self._exc_wrapper(nkeys, options, ldap.delete_entry)(dn)
    ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/baseldap.py", line 1207, in wrapped
    return func(*call_args, **call_kwargs)
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/baseldap.py", line 1215, in exc_func
    return callback(
        self, keys, options, e, call_func, *args, **kwargs)
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/baseldap.py", line 1711, in exc_callback
    raise exc
  File "/usr/lib/python3.14/site-packages/ipaserver/plugins/baseldap.py", line 1207, in wrapped
    return func(*call_args, **call_kwargs)
  File "/usr/lib/python3.14/site-packages/ipapython/ipaldap.py", line 1929, in delete_entry
    super(LDAPCache, self).delete_entry(dn)
    ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^
  File "/usr/lib/python3.14/site-packages/ipapython/ipaldap.py", line 1740, in delete_entry
    with self.error_handler():
         ~~~~~~~~~~~~~~~~~~^^
  File "/usr/lib64/python3.14/contextlib.py", line 162, in __exit__
    self.gen.throw(value)
    ~~~~~~~~~~~~~~^^^^^^^
  File "/usr/lib/python3.14/site-packages/ipapython/ipaldap.py", line 1166, in error_handler
    raise errors.DatabaseError(desc=desc, info=info)

2026-01-10T11:16:16Z DEBUG The ipa-server-upgrade command failed, exception: DatabaseError: Operations error: 
2026-01-10T11:16:16Z ERROR Unexpected error - see /var/log/ipaupgrade.log for details:
DatabaseError: Operations error: 
2026-01-10T11:16:16Z ERROR The ipa-server-upgrade command failed. See /var/log/ipaupgrade.log for more information

In /var/log/dirsrv/slapd-EXAMPLE-TEST/errors I can see

[10/Jan/2026:11:16:13.365328116 +0000] - NOTICE - ldbm_back_search - Unindexed search: search base="ou=authorities,ou=ca,o=ipaca" scope=2 filter="(objectClass=*)" conn=4 op=1
[10/Jan/2026:11:16:13.388642260 +0000] - NOTICE - ldbm_back_search - Unindexed search: search base="ou=certificateProfiles,ou=ca,o=ipaca" scope=2 filter="(objectClass=*)" conn=5 op=2
[10/Jan/2026:11:16:16.182716375 +0000] - WARN - dbmdb_open_dbi_from_filename - Attempt to open to open dbi userRoot/.default while txn is already pending. Usually that means that the index must be reindex. Root cause is likely that last import of reindex failed or that the index was created but not yet reindexed).
[10/Jan/2026:11:16:16.207766840 +0000] - WARN - slapi_log_backtrace -   [0]     /usr/lib64/dirsrv/libslapd.so.0(+0x6d148) [0x7f193666d148]
[10/Jan/2026:11:16:16.223453599 +0000] - WARN - slapi_log_backtrace -   [1]     /usr/lib64/dirsrv/plugins/libback-ldbm.so(dbmdb_open_dbi_from_filename+0x36a) [0x7f1931ade84a]
[10/Jan/2026:11:16:16.239376193 +0000] - WARN - slapi_log_backtrace -   [2]     /usr/lib64/dirsrv/plugins/libback-ldbm.so(dbmdb_get_db+0xbd) [0x7f1931ade92d]
[10/Jan/2026:11:16:16.244379747 +0000] - WARN - slapi_log_backtrace -   [3]     /usr/lib64/dirsrv/plugins/libback-ldbm.so(dblayer_get_index_file+0xb1) [0x7f1931a61631]
[10/Jan/2026:11:16:16.260432957 +0000] - WARN - slapi_log_backtrace -   [4]     /usr/lib64/dirsrv/plugins/libback-ldbm.so(+0x125af) [0x7f1931a635af]
[10/Jan/2026:11:16:16.265241687 +0000] - WARN - slapi_log_backtrace -   [5]     /usr/lib64/dirsrv/plugins/libback-ldbm.so(ldbm_ancestorid_index_entry+0x58) [0x7f1931a638e8]
[10/Jan/2026:11:16:16.279754023 +0000] - WARN - slapi_log_backtrace -   [6]     /usr/lib64/dirsrv/plugins/libback-ldbm.so(index_addordel_entry+0x300) [0x7f1931a75b10]
[10/Jan/2026:11:16:16.283435512 +0000] - WARN - slapi_log_backtrace -   [7]     /usr/lib64/dirsrv/plugins/libback-ldbm.so(ldbm_back_delete+0x13a2) [0x7f1931a8e742]
[10/Jan/2026:11:16:16.297919556 +0000] - WARN - slapi_log_backtrace -   [8]     /usr/lib64/dirsrv/libslapd.so.0(+0x270d0) [0x7f19366270d0]
[10/Jan/2026:11:16:16.301746535 +0000] - WARN - slapi_log_backtrace -   [9]     /usr/lib64/dirsrv/libslapd.so.0(do_delete+0x10f) [0x7f193662748f]
[10/Jan/2026:11:16:16.316020611 +0000] - WARN - slapi_log_backtrace -   [10]    /usr/bin/ns-slapd(+0x126a7) [0x561d7465e6a7]
[10/Jan/2026:11:16:16.319789194 +0000] - WARN - slapi_log_backtrace -   [11]    /lib64/libnspr4.so(+0x24d13) [0x7f1936d31d13]
[10/Jan/2026:11:16:16.334380832 +0000] - WARN - slapi_log_backtrace -   [12]    /lib64/libc.so.6(+0x7227a) [0x7f193647f27a]
[10/Jan/2026:11:16:16.338131058 +0000] - WARN - slapi_log_backtrace -   [13]    /lib64/libc.so.6(+0xf4d5c) [0x7f1936501d5c]
[10/Jan/2026:11:16:16.352379770 +0000] - ERR - ldbm_ancestorid_index_update - ancestorid.c BAD 13130, err=-30798 Unexpected dbimpl error code
[10/Jan/2026:11:16:16.356188014 +0000] - ERR - ldbm_back_delete - index_addordel_entry(idnsname=ipa-ca,idnsname=example.test.,cn=dns,dc=example,dc=test, 0x26) failed (-30798)

Comment 12 Viktor Ashirov 2026-01-10 18:36:00 UTC
New PR: https://github.com/389ds/389-ds-base/pull/7180
I've prepared a copr repo with the latest patch, while the PR is on review: https://copr.fedorainfracloud.org/coprs/vashirov/bz2424132/
It passed your reproducer on my VM.

Thanks.

Comment 13 Jan Pazdziora 2026-01-10 20:50:41 UTC
I confirm that in the containerized FreeIPA setup from which the original issue https://github.com/freeipa/freeipa-container/issues/709 comes, merely adding

RUN dnf copr enable -y vashirov/bz2424132

to the Dockerfile makes upgrades (from fedora-42-4.12.2 and from fedora-43-4.12.5) pass again: https://github.com/adelton/freeipa-container/actions/runs/20882796465.

Comment 14 Fedora Update System 2026-01-12 11:41:33 UTC
FEDORA-2026-092b6c1b30 (389-ds-base-3.2.0-5.fc44) has been submitted as an update to Fedora 44.
https://bodhi.fedoraproject.org/updates/FEDORA-2026-092b6c1b30

Comment 15 Fedora Update System 2026-01-12 13:47:29 UTC
FEDORA-2026-092b6c1b30 (389-ds-base-3.2.0-5.fc44) has been pushed to the Fedora 44 stable repository.
If problem still persists, please make note of it in this bug report.


Note You need to log in before you can comment on or make changes to this bug.