Attachment 13313 Details for Bug 12720 – log.winbindd from an nss info failure case

log.winbindd from an nss info failure case

log.winbindd.nssfailure (text/plain), 16.80 KB, created by Dustin L. Howett on 2017-06-27 14:29:45 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Dustin L. Howett

Created: 2017-06-27 14:29:45 UTC

Size: 16.80 KB

patch

obsolete

>[2017/06/26 17:55:42.959745,  5, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:1135(remove_timed_out_clients)
>  Idle client timed out, shutting down sock 29, pid 30928
>[2017/06/26 17:55:42.959816,  6, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:919(new_connection)
>  accepted socket 26
>[2017/06/26 17:55:42.959861, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:761(process_request)
>  process_request: request fn INTERFACE_VERSION
>[2017/06/26 17:55:42.959874,  3, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_misc.c:395(winbindd_interface_version)
>  [31055]: request interface version (version = 28)
>[2017/06/26 17:55:42.959941, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:864(winbind_client_response_written)
>  winbind_client_response_written[31055:INTERFACE_VERSION]: delivered response to client
>[2017/06/26 17:55:42.959999, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:761(process_request)
>  process_request: request fn WINBINDD_PRIV_PIPE_DIR
>[2017/06/26 17:55:42.960015,  3, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_misc.c:428(winbindd_priv_pipe_dir)
>  [31055]: request location of privileged pipe
>[2017/06/26 17:55:42.960048, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:864(winbind_client_response_written)
>  winbind_client_response_written[31055:WINBINDD_PRIV_PIPE_DIR]: delivered response to client
>[2017/06/26 17:55:42.960093,  6, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:919(new_connection)
>  accepted socket 29
>[2017/06/26 17:55:42.960115,  6, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:968(winbind_client_request_read)
>  closing socket 26, client exited
>[2017/06/26 17:55:42.960142, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:734(process_request)
>  process_request: Handling async request 31055:GETPWNAM
>[2017/06/26 17:55:42.960154,  3, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_getpwnam.c:56(winbindd_getpwnam_send)
>  getpwnam dustin
>[2017/06/26 17:55:42.960178,  1, pid=3971, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:450(ndr_print_function_debug)
>       wbint_LookupName: struct wbint_LookupName
>          in: struct wbint_LookupName
>              domain                   : *
>                  domain                   : 'DELFINO'
>              name                     : *
>                  name                     : 'DUSTIN'
>              flags                    : 0x00000008 (8)
>[2017/06/26 17:55:42.960272,  1, pid=3971, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:450(ndr_print_function_debug)
>       wbint_LookupName: struct wbint_LookupName
>          out: struct wbint_LookupName
>              type                     : *
>                  type                     : SID_NAME_USER (1)
>              sid                      : *
>                  sid                      : S-1-5-21-3995451722-1340852550-1455424223-1104
>              result                   : NT_STATUS_OK
>[2017/06/26 17:55:42.960331, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/wb_sids2xids.c:113(wb_sids2xids_send)
>  SID 0: S-1-5-21-3995451722-1340852550-1455424223-1104
>[2017/06/26 17:55:42.960353, 10, pid=3971, effective(0, 0), real(0, 0)] ../source3/lib/idmap_cache.c:56(idmap_cache_find_sid2unixid)
>  Parsing value for key [IDMAP/SID2XID/S-1-5-21-3995451722-1340852550-1455424223-1104]: value=[501:U]
>[2017/06/26 17:55:42.960362, 10, pid=3971, effective(0, 0), real(0, 0)] ../source3/lib/idmap_cache.c:75(idmap_cache_find_sid2unixid)
>  Parsing value for key [IDMAP/SID2XID/S-1-5-21-3995451722-1340852550-1455424223-1104]: id=[501], endptr=[:U]
>[2017/06/26 17:55:42.960389, 10, pid=3971, effective(0, 0), real(0, 0)] ../source3/libsmb/samlogon_cache.c:242(netsamlogon_cache_get)
>  netsamlogon_cache_get: SID [S-1-5-21-3995451722-1340852550-1455424223-1104]
>[2017/06/26 17:55:42.960428,  1, pid=3971, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:413(ndr_print_debug)
>       &r: struct netsamlogoncache_entry
>          timestamp                : Mon Jun 26 09:04:36 AM 2017 PDT
>          info3: struct netr_SamInfo3
>              base: struct netr_SamBaseInfo
>                  logon_time               : Mon Jun 26 08:10:41 AM 2017 PDT
>                  logoff_time              : Wed Sep 13 07:48:05 PM 30828 PDT
>                  kickoff_time             : Wed Sep 13 07:48:05 PM 30828 PDT
>                  last_password_change     : Sun Jan 29 01:53:29 PM 2017 PST
>                  allow_password_change    : Sun Jan 29 01:53:29 PM 2017 PST
>                  force_password_change    : Wed Sep 13 07:48:05 PM 30828 PDT
>                  account_name: struct lsa_String
>                      length                   : 0x000c (12)
>                      size                     : 0x000c (12)
>                      string                   : *
>                          string                   : 'Dustin'
>                  full_name: struct lsa_String
>                      length                   : 0x0020 (32)
>                      size                     : 0x0020 (32)
>                      string                   : *
>                          string                   : 'Dustin L. Howett'
>                  logon_script: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  profile_path: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  home_directory: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  home_drive: struct lsa_String
>                      length                   : 0x0000 (0)
>                      size                     : 0x0000 (0)
>                      string                   : *
>                          string                   : ''
>                  logon_count              : 0x06c6 (1734)
>                  bad_password_count       : 0x0000 (0)
>                  rid                      : 0x00000450 (1104)
>                  primary_gid              : 0x00000201 (513)
>                  groups: struct samr_RidWithAttributeArray
>                      count                    : 0x00000002 (2)
>                      rids                     : *
>                          rids: ARRAY(2)
>                              rids: struct samr_RidWithAttribute
>                                  rid                      : 0x00000200 (512)
>                                  attributes               : 0x00000007 (7)
>                                         1: SE_GROUP_MANDATORY       
>                                         1: SE_GROUP_ENABLED_BY_DEFAULT
>                                         1: SE_GROUP_ENABLED         
>                                         0: SE_GROUP_OWNER           
>                                         0: SE_GROUP_USE_FOR_DENY_ONLY
>                                         0: SE_GROUP_RESOURCE        
>                                      0x00: SE_GROUP_LOGON_ID         (0)
>                              rids: struct samr_RidWithAttribute
>                                  rid                      : 0x0000023c (572)
>                                  attributes               : 0x00000007 (7)
>                                         1: SE_GROUP_MANDATORY       
>                                         1: SE_GROUP_ENABLED_BY_DEFAULT
>                                         1: SE_GROUP_ENABLED         
>                                         0: SE_GROUP_OWNER           
>                                         0: SE_GROUP_USE_FOR_DENY_ONLY
>                                         0: SE_GROUP_RESOURCE        
>                                      0x00: SE_GROUP_LOGON_ID         (0)
>                  user_flags               : 0x00000000 (0)
>                         0: NETLOGON_GUEST           
>                         0: NETLOGON_NOENCRYPTION    
>                         0: NETLOGON_CACHED_ACCOUNT  
>                         0: NETLOGON_USED_LM_PASSWORD
>                         0: NETLOGON_EXTRA_SIDS      
>                         0: NETLOGON_SUBAUTH_SESSION_KEY
>                         0: NETLOGON_SERVER_TRUST_ACCOUNT
>                         0: NETLOGON_NTLMV2_ENABLED  
>                         0: NETLOGON_RESOURCE_GROUPS 
>                         0: NETLOGON_PROFILE_PATH_RETURNED
>                         0: NETLOGON_GRACE_LOGON     
>                  key: struct netr_UserSessionKey
>                      key                      : 00000000000000000000000000000000
>                  logon_server: struct lsa_StringLarge
>                      length                   : 0x000a (10)
>                      size                     : 0x000c (12)
>                      string                   : *
>                          string                   : 'DENEB'
>                  logon_domain: struct lsa_StringLarge
>                      length                   : 0x000e (14)
>                      size                     : 0x0010 (16)
>                      string                   : *
>                          string                   : 'DELFINO'
>                  domain_sid               : *
>                      domain_sid               : S-1-5-21-3995451722-1340852550-1455424223
>                  LMSessKey: struct netr_LMSessionKey
>                      key                      : 0000000000000000
>                  acct_flags               : 0x00000210 (528)
>                         0: ACB_DISABLED             
>                         0: ACB_HOMDIRREQ            
>                         0: ACB_PWNOTREQ             
>                         0: ACB_TEMPDUP              
>                         1: ACB_NORMAL               
>                         0: ACB_MNS                  
>                         0: ACB_DOMTRUST             
>                         0: ACB_WSTRUST              
>                         0: ACB_SVRTRUST             
>                         1: ACB_PWNOEXP              
>                         0: ACB_AUTOLOCK             
>                         0: ACB_ENC_TXT_PWD_ALLOWED  
>                         0: ACB_SMARTCARD_REQUIRED   
>                         0: ACB_TRUSTED_FOR_DELEGATION
>                         0: ACB_NOT_DELEGATED        
>                         0: ACB_USE_DES_KEY_ONLY     
>                         0: ACB_DONT_REQUIRE_PREAUTH 
>                         0: ACB_PW_EXPIRED           
>                         0: ACB_TRUSTED_TO_AUTHENTICATE_FOR_DELEGATION
>                         0: ACB_NO_AUTH_DATA_REQD    
>                         0: ACB_PARTIAL_SECRETS_ACCOUNT
>                         0: ACB_USE_AES_KEYS         
>                  sub_auth_status          : 0x00000000 (0)
>                  last_successful_logon    : NTTIME(0)
>                  last_failed_logon        : NTTIME(0)
>                  failed_logon_count       : 0x00000000 (0)
>                  reserved                 : 0x00000000 (0)
>              sidcount                 : 0x00000000 (0)
>              sids                     : NULL
>[2017/06/26 17:55:42.961688,  1, pid=3971, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:450(ndr_print_function_debug)
>       wbint_GetNssInfo: struct wbint_GetNssInfo
>          in: struct wbint_GetNssInfo
>              info                     : *
>                  info: struct wbint_userinfo
>                      domain_name              : *
>                          domain_name              : 'DELFINO'
>                      acct_name                : *
>                          acct_name                : 'Dustin'
>                      full_name                : *
>                          full_name                : 'Dustin L. Howett'
>                      homedir                  : *
>                          homedir                  : '/home/%D/%U'
>                      shell                    : *
>                          shell                    : '/bin/false'
>                      uid                      : 0x00000000000001f5 (501)
>                      primary_gid              : 0x00000000ffffffff (4294967295)
>                      primary_group_name       : NULL
>                      user_sid                 : S-1-5-21-3995451722-1340852550-1455424223-1104
>                      group_sid                : S-1-5-21-3995451722-1340852550-1455424223-513
>[2017/06/26 17:55:42.962597,  1, pid=3971, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:450(ndr_print_function_debug)
>       wbint_GetNssInfo: struct wbint_GetNssInfo
>          out: struct wbint_GetNssInfo
>              info                     : *
>                  info: struct wbint_userinfo
>                      domain_name              : *
>                          domain_name              : 'DELFINO'
>                      acct_name                : *
>                          acct_name                : 'Dustin'
>                      full_name                : *
>                          full_name                : 'Dustin L. Howett'
>                      homedir                  : *
>                          homedir                  : '/home/%D/%U'
>                      shell                    : *
>                          shell                    : '/bin/false'
>                      uid                      : 0x00000000000001f5 (501)
>                      primary_gid              : 0x00000000ffffffff (4294967295)
>                      primary_group_name       : NULL
>                      user_sid                 : S-1-5-21-3995451722-1340852550-1455424223-1104
>                      group_sid                : S-1-5-21-3995451722-1340852550-1455424223-513
>              result                   : NT code 0xf2000051
>[2017/06/26 17:55:42.962788, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/wb_sids2xids.c:113(wb_sids2xids_send)
>  SID 0: S-1-5-21-3995451722-1340852550-1455424223-513
>[2017/06/26 17:55:42.962814, 10, pid=3971, effective(0, 0), real(0, 0)] ../source3/lib/idmap_cache.c:56(idmap_cache_find_sid2unixid)
>  Parsing value for key [IDMAP/SID2XID/S-1-5-21-3995451722-1340852550-1455424223-513]: value=[500:G]
>[2017/06/26 17:55:42.962824, 10, pid=3971, effective(0, 0), real(0, 0)] ../source3/lib/idmap_cache.c:75(idmap_cache_find_sid2unixid)
>  Parsing value for key [IDMAP/SID2XID/S-1-5-21-3995451722-1340852550-1455424223-513]: id=[500], endptr=[:G]
>[2017/06/26 17:55:42.962850, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_util.c:1033(find_lookup_domain_from_sid)
>  find_lookup_domain_from_sid: SID [S-1-5-21-3995451722-1340852550-1455424223-513]
>[2017/06/26 17:55:42.962875, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_util.c:1062(find_lookup_domain_from_sid)
>  calling find_our_domain
>[2017/06/26 17:55:42.962892,  1, pid=3971, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:450(ndr_print_function_debug)
>       wbint_LookupSid: struct wbint_LookupSid
>          in: struct wbint_LookupSid
>              sid                      : *
>                  sid                      : S-1-5-21-3995451722-1340852550-1455424223-513
>[2017/06/26 17:55:42.962950,  1, pid=3971, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:450(ndr_print_function_debug)
>       wbint_LookupSid: struct wbint_LookupSid
>          out: struct wbint_LookupSid
>              type                     : *
>                  type                     : SID_NAME_DOM_GRP (2)
>              domain                   : *
>                  domain                   : *
>                      domain                   : 'DELFINO'
>              name                     : *
>                  name                     : *
>                      name                     : 'Domain Users'
>              result                   : NT_STATUS_OK
>[2017/06/26 17:55:42.963122, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:796(wb_request_done)
>  wb_request_done[31055:GETPWNAM]: NT_STATUS_OK
>[2017/06/26 17:55:42.963363, 10, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:864(winbind_client_response_written)
>  winbind_client_response_written[31055:GETPWNAM]: delivered response to client
>[2017/06/26 17:55:42.963394,  6, pid=3971, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:968(winbind_client_request_read)
>  closing socket 29, client exited

Actions: View

Attachments on bug 12720: 13104 | 13105 | 13106 | 13108 | 13313 | 13314 | 13384