Red Hat Bugzilla – Bug 1163742
"debug_timestamps = false" and "debug_microseconds = true" do not work after enabling journald with sssd.
Last modified: 2016-05-05 00:36:00 EDT
Description of problem: "debug_timestamps = false" and "debug_microseconds = true" do not affect after enabling journald with sssd. Version-Release number of selected component (if applicable): sssd-1.12.2-12.el7.x86_64 How reproducible: Always Steps to Reproduce: 1. Enable journald for sssd debug logging 2. Add "debug_timestamps = false" in sssd section and "debug_microseconds = true" in nss section of sssd.conf file. 3. From "journalctl -f" output ---------------------------------------- Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: dbus conn: 0x7fc1b5a32260 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Dispatching. Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Service LDAP replied to ping Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: 0x7fc1b5a32a90 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: dbus conn: 0x7fc1b5a359e0 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Dispatching. Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Service pam replied to ping Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: 0x7fc1b5a353d0 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: dbus conn: 0x7fc1b5a33920 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Dispatching. Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Service nss replied to ping ---------------------------------------- From "journalctl -f" output --------------------------------------------- Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Added timed event "ltdb_timeout": 0x7f84e95b3d00 Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Running timer event 0x7f84e95bf960 "ltdb_callback" Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Destroying timer event 0x7f84e95b3d00 "ltdb_timeout" Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Ending timer event 0x7f84e95bf960 "ltdb_callback" --------------------------------------------- Actual results: From "journalctl -f" output ---------------------------------------- Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: dbus conn: 0x7fc1b5a32260 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Dispatching. Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Service LDAP replied to ping Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: 0x7fc1b5a32a90 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: dbus conn: 0x7fc1b5a359e0 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Dispatching. Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Service pam replied to ping Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: 0x7fc1b5a353d0 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: dbus conn: 0x7fc1b5a33920 Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Dispatching. Nov 13 17:11:01 dhcp207-182.lab.eng.pnq.redhat.com sssd[12980]: Service nss replied to ping ---------------------------------------- From "journalctl -f" output --------------------------------------------- Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Added timed event "ltdb_timeout": 0x7f84e95b3d00 Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Running timer event 0x7f84e95bf960 "ltdb_callback" Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Destroying timer event 0x7f84e95b3d00 "ltdb_timeout" Nov 13 17:10:52 dhcp207-182.lab.eng.pnq.redhat.com sssd_nss[12982]: Ending timer event 0x7f84e95bf960 "ltdb_callback" --------------------------------------------- like both options do not affect Expected results: "debug_timestamps = false" and "debug_microseconds = true" Additional info: Disabling journald for sssd logging and everything works fine.
I wonder if journalctl -f -o short-precise is what you are looking for?
Hi, this is a documentation issue. If journald is used, these options are ignored. I will send a patch to note this in the man pages. Btw. to view microseconds with journalct use the --output=short-precise (see man journalctl for other output formats).
Upstream ticket: https://fedorahosted.org/sssd/ticket/2498
* master: cbbe63ded9d628ffb2494132ca1e5ebe90e2d5f8
Tested with sssd-1.12.2-39.el7.x86_64 1. Install sssd-1.12.2-39.el7.x86_64. 2. From "man sssd.conf" debug_timestamps (bool) Add a timestamp to the debug messages. If journald is enabled for SSSD debug logging this option is ignored. debug_microseconds (bool) Add microseconds to the timestamp in debug messages. If journald is enabled for SSSD debug logging this option is ignored.
Since the problem described in this bug report should be resolved in a recent advisory, it has been closed with a resolution of ERRATA. For information on the advisory, and where to find the updated files, follow the link below. If the solution does not work for you, open a new bug report. https://rhn.redhat.com/errata/RHBA-2015-0441.html