dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30015ms)

Latest response

Hello,

I open this discussion because I have trouble on two RHEL 7 servers.

When I try to connect to them via ssh or when I do an su -l it takes 30sec to accomplish.

When I do su -l I try to log in with an AD user.

When I try to restart sssd I have :

# systemctl restart sssd
Authorization not available. Check if polkit service is running or see debug message for more information.

And an extract of the /var/log/sssd/sssd_my_domain.log with debug_level=4 in sssd.conf when the sssd restart :

(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve A record of 'mydockerhost' in DNS
(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [resolv_gethostbyname_dns_query] (0x0100): Trying to resolve AAAA record of 'mydockerhost' in DNS
(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [resolv_gethostbyname_done] (0x0040): querying hosts database failed [5]: Input/output error
(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [nsupdate_get_addrs_done] (0x0040): Could not resolve address for this machine, error [5]: Input/output error, resolver returned: [11]: Could not contact DNS servers
(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [nsupdate_get_addrs_done] (0x0040): nsupdate_get_addrs_done failed: [5]: [Input/output error]
(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [sdap_dyndns_dns_addrs_done] (0x0040): Could not receive list of current addresses [5]: Input/output error
(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [ad_dyndns_sdap_update_done] (0x0040): Dynamic DNS update failed [5]: Input/output error
(Wed Nov 27 08:11:30 2019) [sssd[be[mydomain.com]]] [ad_dyndns_nsupdate_done] (0x0040): Updating DNS entry failed [5]: Input/output error
(Wed Nov 27 08:11:31 2019) [sssd[be[mydomain.com]]] [sysdb_set_cache_entry_attr] (0x0080): ldb_modify failed: [No such object](32)[ldb_wait from ldb_modify with LDB_WAIT_ALL: No such object (32)]

Then if I check dbus :

# systemctl status dbus
● dbus.service - D-Bus System Message Bus
   Loaded: loaded (/usr/lib/systemd/system/dbus.service; static; vendor preset: disabled)
   Active: active (running) since Mon 2019-11-18 07:48:36 CET; 2 days ago
     Docs: man:dbus-daemon(1)
 Main PID: 1362 (dbus-daemon)
    Tasks: 1
   Memory: 8.3M
   CGroup: /system.slice/dbus.service
           └─1362 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation

Nov 20 14:40:45 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30015ms)
Nov 20 14:41:35 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30007ms)
Nov 20 14:50:31 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30004ms)
Nov 20 15:00:31 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30010ms)
Nov 20 15:01:31 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30021ms)
Nov 20 15:10:31 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30006ms)
Nov 20 15:20:31 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30004ms)
Nov 20 15:22:49 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30008ms)
Nov 20 15:30:31 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30001ms)
Nov 20 15:40:31 myserver dbus[1362]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30003ms)

dbus version :

rpm -qa dbus
dbus-1.10.24-13.el7_6.x86_64

systemd version:

# rpm -qa systemd
systemd-219-67.el7_7.2.x86_64

If I restart dbus, systemd and systemd-logind everything works fine BUT 8 hours later the problem comes back with the same behavior.

For more precision, on this server I'm running GitLab docker container. At the begining I suppose it was due to too many ssh connection but after testing it on another vm I can't reproduce with a script that makes many ssh connection to GitLab.

May be it's due to corrupted packages because the problem occured after an update to the latest version.

How can I troubleshoot this issue and fix it ?

I have added a strace output when I do : su -l

Thank you very much for your help.

Best regards,

Attachments

RC

Responses