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

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
Update to 389-ds-base-1.3.8.4-15.el7.x86_64
Reboot server
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

The servers are virtualized in a vmware enviroment


I think we need to see a core dump or a stacktrace from the process.

After the restart, can you run ns-slapd with:

sudo gdb /sbin/ns-slapd
set args -d 0 -D /etc/dirsrv/slapd-
run

At the point you get the sigbus do:

thread apply all bt

And then please post the output (you may need to page to get it all).

Metadata Update from @firstyear:
- Custom field component adjusted to None
- Custom field origin adjusted to None
- Custom field reviewstatus adjusted to None
- Custom field type adjusted to None
- Custom field version adjusted to None

Any update on Firstyears request for a core file/stack trace? Is this still a problem?

Is this crash still occurring? If so can we get a stacktrace from the core file?

http://www.port389.org/docs/389ds/FAQ/faq.html#debug_crashes

Metadata Update from @firstyear:
- Issue close_status updated to: worksforme
- Issue status updated to: Closed (was: Open)

Hey there, if you can reproduce, please feel free to reopen. Thanks!

389-ds-base is moving from Pagure to Github. This means that new issues and pull requests
will be accepted only in 389-ds-base's github repository.

This issue has been cloned to Github and is available here:
- https://github.com/389ds/389-ds-base/issues/3110

If you want to receive further updates on the issue, please navigate to the github issue
and click on subscribe button.

Thank you for understanding. We apologize for all inconvenience.

Metadata Update from @spichugi:
- Issue close_status updated to: wontfix (was: worksforme)

Metadata