1:37 p.m.
Hi,
I had reporeted while back indicating that sssd subprocess ldap and nss
stops working under heavy load. Looks like even after restart, its getting
SIGKILL.
Running on centos 6.5 and SSSD 1.9.2-129. I looked through the recent
release notes for 1.9. branch but wasn't sure if this has been
reported/fixed yet.
Could you please advise ?
Thanks
from sssd.log
Wed Oct 29 15:44:43:453121 2014) [sssd] [get_ping_config] (0x0100): Time
between service pings for [nss]: [10]
(Wed Oct 29 15:44:43:453191 2014) [sssd] [get_ping_config] (0x0100): Time
between SIGTERM and SIGKILL for [nss]: [60]
(Wed Oct 29 15:44:43:453206 2014) [sssd] [start_service] (0x0100): Queueing
service nss for startup
(Wed Oct 29 15:44:43:669185 2014) [sssd] [get_ping_config] (0x0100): Time
between service pings for [LDAP]: [10]
(Wed Oct 29 15:44:43:669300 2014) [sssd] [get_ping_config] (0x0100): Time
between SIGTERM and SIGKILL for [LDAP]: [60]
(Wed Oct 29 15:44:43:669332 2014) [sssd] [start_service] (0x0100): Queueing
service LDAP for startup
(Wed Oct 29 15:44:47:042335 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Entering.
(Wed Oct 29 15:44:48:769082 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Adding connection 0x69ae40.
(Wed Oct 29 15:44:49:704634 2014) [sssd] [sbus_init_connection] (0x0200):
Adding connection 69AE40
(Wed Oct 29 15:45:35:868409 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Got a connection
(Wed Oct 29 15:45:35:868510 2014) [sssd] [service_send_ping] (0x0100):
Pinging pam
(Wed Oct 29 15:45:35:868773 2014) [sssd] [get_ping_config] (0x0100): Time
between service pings for [nss]: [10]
(Wed Oct 29 15:45:35:868824 2014) [sssd] [get_ping_config] (0x0100): Time
between SIGTERM and SIGKILL for [nss]: [60]
(Wed Oct 29 15:45:35:868844 2014) [sssd] [start_service] (0x0100): Queueing
service nss for startup
(Wed Oct 29 15:45:35:869539 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Entering.
(Wed Oct 29 15:45:35:869580 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Adding connection 0x69c820.
(Wed Oct 29 15:45:35:869596 2014) [sssd] [sbus_init_connection] (0x0200):
Adding connection 69C820
(Wed Oct 29 15:45:35:869641 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Got a connection
(Wed Oct 29 15:45:35:869803 2014) [sssd] [ping_check] (0x0100): Service pam
replied to ping
(Wed Oct 29 15:45:38:543488 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Entering.
(Wed Oct 29 15:45:38:718699 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Adding connection 0x698910.
(Wed Oct 29 15:45:38:718740 2014) [sssd] [sbus_init_connection] (0x0200):
Adding connection 698910
(Wed Oct 29 15:45:38:718795 2014) [sssd] [sbus_server_init_new_connection]
(0x0200): Got a connection
(Wed Oct 29 15:45:45:006440 2014) [sssd] [service_send_ping] (0x0100):
Pinging pam
(Wed Oct 29 15:45:45:006711 2014) [sssd] [ping_check] (0x0100): Service pam
replied to ping
(Wed Oct 29 15:45:45:869420 2014) [sssd] [sbus_disconnect] (0x0200):
Disconnecting 69AE40
(Wed Oct 29 15:45:45:869534 2014) [sssd]
[sbus_default_connection_destructor] (0x0200): Invoking default destructor
on connection 69AE40
(Wed Oct 29 15:45:45:869609 2014) [sssd] [sbus_disconnect] (0x0200):
Disconnected 69AE40
(Wed Oct 29 15:45:45:870728 2014) [sssd] [sbus_disconnect] (0x0200):
Disconnecting 69C820
(Wed Oct 29 15:45:45:870765 2014) [sssd]
[sbus_default_connection_destructor] (0x0200): Invoking default destructor
on connection 69C820
(Wed Oct 29 15:45:45:870802 2014) [sssd] [sbus_disconnect] (0x0200):
Disconnected 69C820
(Wed Oct 29 15:45:48:721481 2014) [sssd] [sbus_disconnect] (0x0200):
Disconnecting 698910
(Wed Oct 29 15:45:48:721584 2014) [sssd]
[sbus_default_connection_destructor] (0x0200): Invoking default destructor
on connection 698910
(Wed Oct 29 15:45:48:721669 2014) [sssd] [sbus_disconnect] (0x0200):
Disconnected 698910
from sssd-ldap.log
(Wed Oct 29 15:44:47:798536 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Entering.
(Wed Oct 29 15:44:47:798555 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Adding connection 0x6bb740.
(Wed Oct 29 15:44:47:798582 2014) [sssd[be[LDAP]]] [sbus_init_connection]
(0x0200): Adding connection 6BB740
(Wed Oct 29 15:44:47:798614 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Got a connection
(Wed Oct 29 15:44:50:226352 2014) [sssd[be[LDAP]]] [id_callback] (0x0010):
The Monitor returned an error [org.freedesktop.DBus.Error.NoReply]
(Wed Oct 29 15:45:36:489821 2014) [sssd[be[LDAP]]] [cleanup_users]
(0x0200): User mapred is still logged in or a dummy entry, keeping data
(Wed Oct 29 15:46:01:521917 2014) [sssd[be[LDAP]]]
[resolv_gethostbyname_next] (0x0200): No more address families to retry
(Wed Oct 29 15:46:01:534696 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Entering.
(Wed Oct 29 15:46:01:534727 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Adding connection 0x6f0420.
(Wed Oct 29 15:46:01:534740 2014) [sssd[be[LDAP]]] [sbus_init_connection]
(0x0200): Adding connection 6F0420
(Wed Oct 29 15:46:01:534763 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Got a connection
(Wed Oct 29 15:46:01:654795 2014) [sssd[be[LDAP]]]
[be_resolve_server_process] (0x0200): Found address for server server name:
TTL 3600
(Wed Oct 29 15:46:01:712980 2014) [sssd[be[LDAP]]] [get_naming_context]
(0x0200): Using value from [namingContexts] as naming context.
(Wed Oct 29 15:46:01:745392 2014) [sssd[be[LDAP]]]
[sdap_get_server_opts_from_rootdse] (0x0200): No known USN scheme is
supported by this server!
(Wed Oct 29 15:46:01:745419 2014) [sssd[be[LDAP]]]
[sdap_get_server_opts_from_rootdse] (0x0200): Will use modification
timestamp as usn!
(Wed Oct 29 15:46:09:017362 2014) [sssd[be[LDAP]]] [init_timeout] (0x0040):
Client timed out before Identification [0x70fbf0]!
(Wed Oct 29 15:46:09:017415 2014) [sssd[be[LDAP]]] [sbus_disconnect]
(0x0200): Disconnecting 6F0420
(Wed Oct 29 15:46:09:017452 2014) [sssd[be[LDAP]]]
[sbus_default_connection_destructor] (0x0200): Invoking default destructor
on connection 6F0420
(Wed Oct 29 15:46:09:017510 2014) [sssd[be[LDAP]]] [sbus_disconnect]
(0x0200): Disconnected 6F0420
(Wed Oct 29 15:46:10:509589 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Entering.
(Wed Oct 29 15:46:10:509635 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Adding connection 0x6c7360.
(Wed Oct 29 15:46:10:509647 2014) [sssd[be[LDAP]]] [sbus_init_connection]
(0x0200): Adding connection 6C7360
(Wed Oct 29 15:46:10:509676 2014) [sssd[be[LDAP]]]
[sbus_server_init_new_connection] (0x0200): Got a connection
from messages
Oct 29 15:44:43 hostname sssd[nss]: Shutting down
Oct 29 15:44:43 hostname sssd[be[LDAP]]: Shutting down
Oct 29 15:44:46 hostname sssd[nss]: Starting up
Oct 29 15:44:46 hostname sssd[be[LDAP]]: Starting up
Oct 29 15:45:38 hostname sssd[nss]: Starting up