freeipa

#7773 After update and reboot a FreeIPA server, Dirsrv don't start, debug show bus error
Closed: invalid by rcritten. Opened by carlinhos7000.

Closed: invalid
Reopen Issue

Sorry by my english, is not my native language.

After update and reboot my FreeIPA server dirsrv don't start, looking in logs the service entered failed state with status 7/BUS.

This is the output of /usr/sbin/ns-slapd command with debug level 9

45379584, system_available_pages = 369479, system_available_bytes = 1513385984},
[26/Nov/2018:12:26:52.511681622 +0100] - DEBUG - util_is_cachesize_sane - Available bytes 1513385984, requested bytes 67108864
[26/Nov/2018:12:26:52.527744438 +0100] - DEBUG - spal_meminfo_get - system_total_bytes - using memtotal
[26/Nov/2018:12:26:52.541870069 +0100] - DEBUG - spal_meminfo_get - system_available_bytes - using memavail
[26/Nov/2018:12:26:52.554983810 +0100] - DEBUG - spal_meminfo_get - {pagesize_bytes = 4096, system_total_pages = 445879, system_total_bytes = 1826320384, process_consumed_pages = 11082, process_consumed_bytes = 45391872, system_available_pages = 369479, system_available_bytes = 1513385984},
[26/Nov/2018:12:26:52.568830248 +0100] - DEBUG - util_is_cachesize_sane - Available bytes 1513385984, requested bytes 67108864
[26/Nov/2018:12:26:52.583969887 +0100] - DEBUG - spal_meminfo_get - system_total_bytes - using memtotal
[26/Nov/2018:12:26:52.606012457 +0100] - DEBUG - spal_meminfo_get - system_available_bytes - using memavail
[26/Nov/2018:12:26:52.619395963 +0100] - DEBUG - spal_meminfo_get - {pagesize_bytes = 4096, system_total_pages = 445879, system_total_bytes = 1826320384, process_consumed_pages = 11083, process_consumed_bytes = 45395968, system_available_pages = 369448, system_available_bytes = 1513259008},
[26/Nov/2018:12:26:52.633300769 +0100] - DEBUG - util_is_cachesize_sane - Available bytes 1513259008, requested bytes 67108864
[26/Nov/2018:12:26:52.646810164 +0100] - DEBUG - spal_meminfo_get - system_total_bytes - using memtotal
[26/Nov/2018:12:26:52.661505405 +0100] - DEBUG - spal_meminfo_get - system_available_bytes - using memavail
[26/Nov/2018:12:26:52.674964425 +0100] - DEBUG - spal_meminfo_get - {pagesize_bytes = 4096, system_total_pages = 445879, system_total_bytes = 1826320384, process_consumed_pages = 11085, process_consumed_bytes = 45404160, system_available_pages = 369448, system_available_bytes = 1513259008},
[26/Nov/2018:12:26:52.689466114 +0100] - DEBUG - util_is_cachesize_sane - Available bytes 1513259008, requested bytes 67108864
[26/Nov/2018:12:26:52.703204641 +0100] - DEBUG - util_is_cachesize_sane - Available bytes 1513373696, requested bytes 461095436
[26/Nov/2018:12:26:52.712930767 +0100] - DEBUG - spal_meminfo_get - system_total_bytes - using memtotal
[26/Nov/2018:12:26:52.715670339 +0100] - DEBUG - spal_meminfo_get - system_available_bytes - using memavail
[26/Nov/2018:12:26:52.718444575 +0100] - DEBUG - spal_meminfo_get - {pagesize_bytes = 4096, system_total_pages = 445879, system_total_bytes = 1826320384, process_consumed_pages = 11086, process_consumed_bytes = 45408256, system_available_pages = 369448, system_available_bytes = 1513259008},
[26/Nov/2018:12:26:52.721087212 +0100] - DEBUG - util_is_cachesize_sane - Available bytes 1513259008, requested bytes 58442252
[26/Nov/2018:12:26:52.724090537 +0100] - DEBUG - dblayer_override_libdb_function - Enabled 64-bit files
[26/Nov/2018:12:26:52.727628423 +0100] - DEBUG - dblayer_dump_config_tracing - home_directory=/var/lib/dirsrv/slapd-BMESFTP-COM/db
[26/Nov/2018:12:26:52.730273573 +0100] - DEBUG - dblayer_dump_config_tracing - log_directory=/var/lib/dirsrv/slapd-BMESFTP-COM/db
[26/Nov/2018:12:26:52.733002770 +0100] - DEBUG - dblayer_dump_config_tracing - dbhome_directory=
[26/Nov/2018:12:26:52.736039310 +0100] - DEBUG - dblayer_dump_config_tracing - trickle_percentage=5
[26/Nov/2018:12:26:52.738983906 +0100] - DEBUG - dblayer_dump_config_tracing - page_size=0
[26/Nov/2018:12:26:52.741834180 +0100] - DEBUG - dblayer_dump_config_tracing - index_page_size=0
[26/Nov/2018:12:26:52.744600064 +0100] - DEBUG - dblayer_dump_config_tracing - cachesize=58442252
[26/Nov/2018:12:26:52.747598509 +0100] - DEBUG - dblayer_dump_config_tracing - previous_cachesize=0
[26/Nov/2018:12:26:52.750459849 +0100] - DEBUG - dblayer_dump_config_tracing - ncache=0
[26/Nov/2018:12:26:52.753190031 +0100] - DEBUG - dblayer_dump_config_tracing - previous_ncache=0
[26/Nov/2018:12:26:52.755848790 +0100] - DEBUG - dblayer_dump_config_tracing - recovery_required=0
[26/Nov/2018:12:26:52.758790156 +0100] - DEBUG - dblayer_dump_config_tracing - durable_transactions=1
[26/Nov/2018:12:26:52.761772993 +0100] - DEBUG - dblayer_dump_config_tracing - checkpoint_interval=60
[26/Nov/2018:12:26:52.765046570 +0100] - DEBUG - dblayer_dump_config_tracing - transaction_batch_val=0
[26/Nov/2018:12:26:52.767762242 +0100] - DEBUG - dblayer_dump_config_tracing - circular_logging=1
[26/Nov/2018:12:26:52.770726041 +0100] - DEBUG - dblayer_dump_config_tracing - idl_divisor=0
[26/Nov/2018:12:26:52.773524098 +0100] - DEBUG - dblayer_dump_config_tracing - logfile_size=0
[26/Nov/2018:12:26:52.776243721 +0100] - DEBUG - dblayer_dump_config_tracing - logbuf_size=0
[26/Nov/2018:12:26:52.779194521 +0100] - DEBUG - dblayer_dump_config_tracing - file_mode=384
[26/Nov/2018:12:26:52.782067845 +0100] - DEBUG - dblayer_dump_config_tracing - cache_config=0
[26/Nov/2018:12:26:52.784899324 +0100] - DEBUG - dblayer_dump_config_tracing - lib_version=2
[26/Nov/2018:12:26:52.789498678 +0100] - DEBUG - dblayer_dump_config_tracing - spin_count=0
[26/Nov/2018:12:26:52.792621033 +0100] - DEBUG - dblayer_dump_config_tracing - named_regions=0
[26/Nov/2018:12:26:52.795575565 +0100] - DEBUG - dblayer_dump_config_tracing - private mem=0
[26/Nov/2018:12:26:52.798694373 +0100] - DEBUG - dblayer_dump_config_tracing - private import mem=1
[26/Nov/2018:12:26:52.801528218 +0100] - DEBUG - dblayer_dump_config_tracing - shm_key=389389
[26/Nov/2018:12:26:52.804599124 +0100] - DEBUG - dblayer_dump_config_tracing - lockdown=0
[26/Nov/2018:12:26:52.807417395 +0100] - DEBUG - dblayer_dump_config_tracing - locks=10000
[26/Nov/2018:12:26:52.809981187 +0100] - DEBUG - dblayer_dump_config_tracing - previous_locks=0
[26/Nov/2018:12:26:52.812707407 +0100] - DEBUG - dblayer_dump_config_tracing - tx_max=200
Bus error

Now, the wierdtest thing if I manually run /usr/sbin/setup-ds.pl -u -s General.UpdateMode=offline, and then start dirsrv, the service works perfectly, but if the server is restarted, dirsrv won't start again until I run setup-ds.pl. This situation occurs in both replicated nodes

Steps to Reproduce

  1. Update to 389-ds-base-1.3.8.4-15.el7.x86_64
  2. Reboot server
  3. ipactl start

Distribution: Oracle Linux 7.6
packages:
ipa-server-4.6.4-10.0.1.el7.x86_64
ipa-client-4.6.4-10.0.1.el7.x86_64
389-ds-base-1.3.8.4-15.el7.x86_64
pki-ca-10.5.9-6.el7.noarch
krb5-server-1.15.1-34.el7.x86_64

A bus error is very similar to a segmentation fault. The 389-DS LDAP server is crashing because it tries to access invalid memory. On a X86_64 a bus error typically signals an invalid mmap or a hardware problem.

Please report the problem at https://pagure.io/389-ds-base/.

Done: https://pagure.io/389-ds-base/issue/50051

The servers are virtualized in a vmware enviroment

Closing this as it is being tracked by 389-ds.

Metadata Update from @rcritten:
- Issue close_status updated to: invalid
- Issue status updated to: Closed (was: Open)
Metadata
None
None
None
None
None
Static archive. pagure.io was sunset in 2026; this is a read-only snapshot.
Red Hat Logo

Fedora is sponsored by Red Hat. Learn more about the relationship between Red Hat and Fedora »

© Red Hat, Inc. and others.