[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