#2030 getent response requires sssd restart after trust add

Created 4 years ago by steeve
Modified 9 months ago

getent passwd/group gives no response after trust is added for the first time. It works after sssd is restarted.

==> /var/log/sssd/sssd_nss.log <==
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [get_client_cred] (0x4000): Client creds: euid[0] egid[0] pid[29533].
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [accept_fd_handler] (0x0400): Client connected!
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sss_cmd_get_version] (0x0200): Received client version [1].
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sss_cmd_get_version] (0x0200): Offered version [1].
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [nss_cmd_getbynam] (0x0400): Running command [33] with input [testgroup@ADLABS.COM].
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sss_dp_issue_request] (0x0400): Issuing request for [0x7f2ad94ece00:domains@ipa.example.org]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sss_dp_get_domains_msg] (0x0400): Sending get domains request for [ipa.example.org][forced][ADLABS.COM]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sbus_add_timeout] (0x2000): 0x7f2adae6c790
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sss_dp_internal_get_send] (0x0400): 
==> /var/log/sssd/sssd_ipa.example.org.log <==
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [sbus_dispatch] (0x4000): 
==> /var/log/sssd/sssd_nss.log <==
Entering request [0x7f2ad94ece00:domains@ipa.example.org]

==> /var/log/sssd/sssd_ipa.example.org.log <==
dbus conn: 7F84877CE990
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [sbus_dispatch] (0x4000): Dispatching.
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [sbus_message_handler] (0x4000): Received SBUS method [getDomains]
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [be_get_subdomains] (0x0400): Got get subdomains [forced][ADLABS.COM]
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [be_queue_request] (0x4000): Queue is empty, running request immediately.
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [be_queue_request] (0x4000): Adding request to queue.
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [ipa_subdomains_handler] (0x4000): Subdomain provider disabled.
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [get_subdomains_callback] (0x0400): Backend returned: (0, 0, <NULL>) [Success]
(Thu Jul 25 20:15:40 2013) [sssd[be[ipa.example.org]]] [be_queue_next_request] (0x4000): Request queue is empty.

==> /var/log/sssd/sssd_nss.log <==
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sbus_remove_timeout] (0x2000): 0x7f2adae6c790
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sbus_dispatch] (0x4000): dbus conn: 7F2ADAE6CD40
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sbus_dispatch] (0x4000): Dispatching.
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sss_dp_get_reply] (0x1000): Got reply from Data Provider - DP error code: 0 errno: 0 error message: Success
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_callback": 0x7f2adae7e5e0

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_timeout": 0x7f2adae7e710

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Running timer event 0x7f2adae7e5e0 "ltdb_callback"

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Destroying timer event 0x7f2adae7e710 "ltdb_timeout"

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Ending timer event 0x7f2adae7e5e0 "ltdb_callback"

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_callback": 0x7f2adae7e710

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_timeout": 0x7f2adae785e0

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Running timer event 0x7f2adae7e710 "ltdb_callback"

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Destroying timer event 0x7f2adae785e0 "ltdb_timeout"

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [ldb] (0x4000): Ending timer event 0x7f2adae7e710 "ltdb_callback"

(Thu Jul 25 20:15:40 2013) [sssd[nss]] [nss_cmd_getbynam_done] (0x0040): Invalid name received [testgroup@ADLABS.COM]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [sss_dp_req_destructor] (0x0400): Deleting request: [0x7f2ad94ece00:domains@ipa.example.org]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [client_recv] (0x0200): Client disconnected!
(Thu Jul 25 20:15:40 2013) [sssd[nss]] [client_destructor] (0x2000): Terminated client [0x7f2adae738b0][23]

==> /var/log/sssd/sssd_ipa.example.org.log <==
(Thu Jul 25 20:15:43 2013) [sssd[be[ipa.example.org]]] [sbus_dispatch] (0x4000): dbus conn: 7F84877B72A0

==> /var/log/sssd/sssd_nss.log <==
(Thu Jul 25 20:15:43 2013) [sssd[nss]] [sbus_dispatch] (0x4000): 
==> /var/log/sssd/sssd_ipa.example.org.log <==
(Thu Jul 25 20:15:43 2013) [sssd[be[ipa.example.org]]] [sbus_dispatch] (0x4000): Dispatching.
(Thu Jul 25 20:15:43 2013) [sssd[be[ipa.example.org]]] [sbus_message_handler] (0x4000): Received SBUS method [ping]

==> /var/log/sssd/sssd_nss.log <==
dbus conn: 7F2ADAE6FEF0
(Thu Jul 25 20:15:43 2013) [sssd[nss]] [sbus_dispatch] (0x4000): Dispatching.
(Thu Jul 25 20:15:43 2013) [sssd[nss]] [sbus_message_handler] (0x4000): Received SBUS method [ping]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [get_client_cred] (0x4000): Client creds: euid[0] egid[0] pid[29534].
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [accept_fd_handler] (0x0400): Client connected!
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sss_cmd_get_version] (0x0200): Received client version [1].
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sss_cmd_get_version] (0x0200): Offered version [1].
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [nss_cmd_getbynam] (0x0400): Running command [17] with input [testuser@ADLABS.COM].
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sss_dp_issue_request] (0x0400): Issuing request for [0x7f2ad94ece00:domains@ipa.example.org]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sss_dp_get_domains_msg] (0x0400): Sending get domains request for [ipa.example.org][forced][ADLABS.COM]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sbus_add_timeout] (0x2000): 0x7f2adae6cfd0
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sss_dp_internal_get_send] (0x0400): Entering request [0x7f2ad94ece00:domains@ipa.example.org]

==> /var/log/sssd/sssd_ipa.example.org.log <==
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [sbus_dispatch] (0x4000): dbus conn: 7F84877CE990
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [sbus_dispatch] (0x4000): Dispatching.
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [sbus_message_handler] (0x4000): Received SBUS method [getDomains]
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [be_get_subdomains] (0x0400): Got get subdomains [forced][ADLABS.COM]
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [be_queue_request] (0x4000): Queue is empty, running request immediately.
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [be_queue_request] (0x4000): Adding request to queue.
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [ipa_subdomains_handler] (0x4000): Subdomain provider disabled.
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [get_subdomains_callback] (0x0400): Backend returned: (0, 0, <NULL>) [Success]
(Thu Jul 25 20:15:45 2013) [sssd[be[ipa.example.org]]] [be_queue_next_request] (0x4000): Request queue is empty.

==> /var/log/sssd/sssd_nss.log <==
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sbus_remove_timeout] (0x2000): 0x7f2adae6cfd0
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sbus_dispatch] (0x4000): dbus conn: 7F2ADAE6CD40
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sbus_dispatch] (0x4000): Dispatching.
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sss_dp_get_reply] (0x1000): Got reply from Data Provider - DP error code: 0 errno: 0 error message: Success
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_callback": 0x7f2adae7e5e0

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_timeout": 0x7f2adae7e710

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Running timer event 0x7f2adae7e5e0 "ltdb_callback"

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Destroying timer event 0x7f2adae7e710 "ltdb_timeout"

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Ending timer event 0x7f2adae7e5e0 "ltdb_callback"

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_callback": 0x7f2adae7e710

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Added timed event "ltdb_timeout": 0x7f2adae785e0

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Running timer event 0x7f2adae7e710 "ltdb_callback"

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Destroying timer event 0x7f2adae785e0 "ltdb_timeout"

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [ldb] (0x4000): Ending timer event 0x7f2adae7e710 "ltdb_callback"

(Thu Jul 25 20:15:45 2013) [sssd[nss]] [nss_cmd_getbynam_done] (0x0040): Invalid name received [testuser@ADLABS.COM]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [sss_dp_req_destructor] (0x0400): Deleting request: [0x7f2ad94ece00:domains@ipa.example.org]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [reset_idle_timer] (0x4000): Idle timer re-set for client [0x7f2adae738b0][23]
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [client_recv] (0x0200): Client disconnected!
(Thu Jul 25 20:15:45 2013) [sssd[nss]] [client_destructor] (0x2000): Terminated client [0x7f2adae738b0][23]

Fields changed

milestone: NEEDS_TRIAGE => SSSD 1.11
rhbz: => 0

This is more of a usability/timeout bug.

priority: major => minor

Will be fixed in 1.11.2

milestone: SSSD 1.11.1 => SSSD 1.11.2

Several use cases:

- Server case - we need to restart SSSD on servers. Send signal to SSSD or do service restart.
- Client case - signal clients to restart. This mechanism does not exist. SSSD will re-fetch in a matter of minutes so this is not a big deal. Restarting clients would be another potential use case for OpenLMI.

We are going to focus on the server side case in the scope of this ticket.

Fields changed

owner: somebody => sbose
status: new => assigned

Fields changed

patch: 0 => 1

resolution: => fixed
status: assigned => closed

Fields changed

changelog: => N/A this is mostly a bugfix

9 months ago

Metadata Update from @steeve:
- Issue assigned to sbose
- Issue set to the milestone: SSSD 1.11.2

Login to comment on this ticket.

defect

SSSD

1.10.1

0

1

0

0

0

N/A this is mostly a bugfix

cancel