Learn more about these different git repos.
Other Git URLs
Cloned from https://bugzilla.redhat.com/show_bug.cgi?id=587521
Description of problem: Junk characters displayed while enumerating users and authentication fails. However, after restarting nslcd and sssd services the junk characters for puser1 disappears and authentication succeeds.
Version-Release number of selected component (if applicable): sssd-1.1.1-5.el6.x86_64
How reproducible: Always
Steps to Reproduce: 1. Configure proxy domain for SSSD.
cat /etc/sssd/sssd.conf: {{{ [sssd] config_file_version = 2 domains = proxy reconnection_retries = 3 services = nss, pam debug_level = 6
[nss] debug_level = 4 filter_groups = root, jenny filter_users = root, jenny reconnection_retries = 3
[pam] reconnection_retries = 3
[domain/proxy] enumerate = True auth_provider = proxy cache_credentials = True id_provider = proxy proxy_lib_name = ldap proxy_pam_target = sssdproxyldap debug_level = 9 lookup_family_order = ipv6_only }}}
Actual results 3: {{{ # getent -s sss passwd puser1::1001:1001:Posix User1:/export/puser1: puser2::1002:1002:Posix User2:/export/puser2: puser4:*:1011:1011:Posix User4:/export/puser4: }}}
Actual results 4: {{{ # ssh -l puser1 localhost puser1@localhost's password: Last login: Thu Apr 29 20:48:13 2010 from localhost.localdomain -sh-4.1$ }}}
<snip /var/log/sssd/sssd_proxy.log> {{{ (Fri Apr 30 10:45:48 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71B510 (Fri Apr 30 10:45:48 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:45:48 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [ping] (Fri Apr 30 10:45:50 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:45:50 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:45:50 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Fri Apr 30 10:45:50 2010) [sssd[be[proxy]]] [be_get_account_info] (4): Got request for [3][1][name=puser1] (Fri Apr 30 10:45:50 2010) [sssd[be[proxy]]] [ldb] (9): start ldb transaction (nesting: 0) (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [get_initgr_groups_process] (2): proxy -> initgroups_dyn failed (0)[Success] (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [ldb] (9): cancel ldb transaction (nesting: 0) (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [acctinfo_callback] (4): Request processed. Returned 3,5,Internal Error (Input/output error) (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Got request with the following data (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): command: 241 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): domain: proxy (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): user: puser1 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): service: sshd (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): tty: ssh (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): ruser: (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): rhost: localhost.localdomain (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok type: 1 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok size: 9 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok type: 0 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok size: 0 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): priv: 1 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [pam_print_data] (4): cli_pid: 15504 (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [proxy_pam_handler] (1): Pam transaction started. (Fri Apr 30 10:45:54 2010) [sssd[be[proxy]]] [proxy_internal_conv] (4): Conversation message: [Password: ] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [proxy_pam_handler] (4): Pam result: [0][Success] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_pam_handler_callback] (4): Backend returned: (0, 0, <NULL>) [Success] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_pam_handler_callback] (4): Sending result [0][proxy] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_pam_handler_callback] (4): Sent result [0][proxy] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Got request with the following data (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): command: 243 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): domain: proxy (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): user: puser1 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): service: sshd (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): tty: ssh (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): ruser: (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): rhost: localhost.localdomain (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok type: 0 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok size: 0 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok type: 0 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok size: 0 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): priv: 1 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [pam_print_data] (4): cli_pid: 15504 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_target_access_permit] (9): be_target_access_permit called, returning PAM_SUCCESS. (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_pam_handler_callback] (4): Backend returned: (0, 0, <NULL>) [Success] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_pam_handler_callback] (4): Sending result [0][proxy] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_pam_handler_callback] (4): Sent result [0][proxy] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71F5B0 (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [be_get_account_info] (4): Got request for [4099][1][name=puser1] (Fri Apr 30 10:45:56 2010) [sssd[be[proxy]]] [ldb] (9): start ldb transaction (nesting: 0) (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [get_initgr_groups_process] (2): proxy -> initgroups_dyn failed (0)[Success] (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [ldb] (9): cancel ldb transaction (nesting: 0) (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [acctinfo_callback] (4): Request processed. Returned 3,5,Internal Error (Input/output error) (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71B510 (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [ping] (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [be_get_account_info] (4): Got request for [3][1][name=puser1] (Fri Apr 30 10:46:01 2010) [sssd[be[proxy]]] [ldb] (9): start ldb transaction (nesting: 0) (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [get_initgr_groups_process] (2): proxy -> initgroups_dyn failed (0)[Success] (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [ldb] (9): cancel ldb transaction (nesting: 0) (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [acctinfo_callback] (4): Request processed. Returned 3,5,Internal Error (Input/output error) (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Got request with the following data (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): command: 242 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): domain: proxy (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): user: puser1 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): service: sshd (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): tty: ssh (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): ruser: (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): rhost: localhost.localdomain (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok type: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok size: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok type: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok size: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): priv: 1 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): cli_pid: 15504 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Sending result [0][proxy] (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Got request with the following data (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): command: 244 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): domain: proxy (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): user: puser1 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): service: sshd (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): tty: ssh (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): ruser: (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): rhost: localhost.localdomain (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok type: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok size: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok type: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok size: 0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): priv: 1 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [pam_print_data] (4): cli_pid: 15504 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Sending result [0][proxy] (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71F5B0 (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [be_get_account_info] (4): Got request for [4099][1][name=puser1] (Fri Apr 30 10:46:02 2010) [sssd[be[proxy]]] [ldb] (9): start ldb transaction (nesting: 0) (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [get_initgr_groups_process] (2): proxy -> initgroups_dyn failed (0)[Success] (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [ldb] (9): cancel ldb transaction (nesting: 0) (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [acctinfo_callback] (4): Request processed. Returned 3,5,Internal Error (Input/output error) (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [getAccountInfo] (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [be_get_account_info] (4): Got request for [3][1][name=puser1] (Fri Apr 30 10:46:03 2010) [sssd[be[proxy]]] [ldb] (9): start ldb transaction (nesting: 0) (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [get_initgr_groups_process] (2): proxy -> initgroups_dyn failed (0)[Success] (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [ldb] (9): cancel ldb transaction (nesting: 0) (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [acctinfo_callback] (4): Request processed. Returned 3,5,Internal Error (Input/output error) (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71ED30 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [pamHandler] (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Got request with the following data (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): command: 242 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): domain: proxy (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): user: puser1 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): service: sshd (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): tty: ssh (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): ruser: (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): rhost: localhost.localdomain (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok type: 0 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): authtok size: 0 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok type: 0 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): newauthtok size: 0 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): priv: 0 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [pam_print_data] (4): cli_pid: 15506 (Fri Apr 30 10:46:04 2010) [sssd[be[proxy]]] [be_pam_handler] (4): Sending result [0][proxy] (Fri Apr 30 10:46:08 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): dbus conn: 71B510 (Fri Apr 30 10:46:08 2010) [sssd[be[proxy]]] [sbus_dispatch] (9): Dispatching. (Fri Apr 30 10:46:08 2010) [sssd[be[proxy]]] [sbus_message_handler] (9): Received SBUS method [ping] <snip> }}}
Expected results: Junk characters should not be displayed while enumerating user identities.
Additional info:
Fields changed
milestone: NEEDS_TRIAGE => SSSD 1.2.0 reporter: sgallagh => jhrozek
owner: simo => jhrozek reporter: jhrozek => sgallagh
During a debugging session, Simo found out that this is actually a bug in nss_ldap as this is reproducible also when asking the ldap NSS module directly. SSSD in this case only displays the data it got via the proxy provider.
resolution: => invalid status: new => closed
rhbz: => [https://bugzilla.redhat.com/show_bug.cgi?id=587521 587521]
Metadata Update from @sgallagh: - Issue assigned to jhrozek - Issue set to the milestone: SSSD 1.2.0
SSSD is moving from Pagure to Github. This means that new issues and pull requests will be accepted only in SSSD's github repository.
This issue has been cloned to Github and is available here: - https://github.com/SSSD/sssd/issues/1516
If you want to receive further updates on the issue, please navigate to the github issue and click on subscribe button.
subscribe
Thank you for understanding. We apologize for all inconvenience.
Login to comment on this ticket.