getent passwd rowland rowland:*:10000:10000:Rowland Penny:/home/rowland:/bin/bash [2017/03/26 11:35:13.825938, 6, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:919(new_connection) accepted socket 26 [2017/03/26 11:35:13.825993, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:761(process_request) process_request: request fn INTERFACE_VERSION [2017/03/26 11:35:13.826005, 3, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_misc.c:395(winbindd_interface_version) [27844]: request interface version (version = 28) [2017/03/26 11:35:13.826017, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:864(winbind_client_response_written) winbind_client_response_written[27844:INTERFACE_VERSION]: delivered response to client [2017/03/26 11:35:13.826047, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:761(process_request) process_request: request fn WINBINDD_PRIV_PIPE_DIR [2017/03/26 11:35:13.826052, 3, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_misc.c:428(winbindd_priv_pipe_dir) [27844]: request location of privileged pipe [2017/03/26 11:35:13.826064, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:864(winbind_client_response_written) winbind_client_response_written[27844:WINBINDD_PRIV_PIPE_DIR]: delivered response to client [2017/03/26 11:35:13.826176, 6, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:919(new_connection) accepted socket 28 [2017/03/26 11:35:13.826204, 6, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:968(winbind_client_request_read) closing socket 26, client exited [2017/03/26 11:35:13.826216, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:734(process_request) process_request: Handling async request 27844:GETPWNAM [2017/03/26 11:35:13.826221, 3, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_getpwnam.c:56(winbindd_getpwnam_send) getpwnam rowland [2017/03/26 11:35:13.826229, 5, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:180(get_cache) get_cache: Setting ADS methods for domain SAMDOM [2017/03/26 11:35:13.826239, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:477(fetch_cache_seqnum) fetch_cache_seqnum: success [SAMDOM][70699 @ 1490524241] [2017/03/26 11:35:13.826243, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:596(refresh_sequence_number) refresh_sequence_number: SAMDOM seq number is now 70699 [2017/03/26 11:35:13.826249, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:642(centry_expired) centry_expired: Key NSS/AN/ROWLAND for domain SAMDOM expired [2017/03/26 11:35:13.826253, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:737(wcache_fetch) wcache_fetch: entry NSS/AN/ROWLAND expired for domain SAMDOM [2017/03/26 11:35:13.826260, 5, pid=27649, effective(0, 0), real(0, 0)] ../source3/winbindd/nss_info.c:80(smb_register_idmap_nss) smb_register_idmap_nss: Successfully added idmap nss backend 'template' [2017/03/26 11:35:13.826263, 10, pid=27649, effective(0, 0), real(0, 0)] ../source3/winbindd/nss_info.c:191(nss_init) parsed backend = 'template', domain = '(null)' [2017/03/26 11:35:13.826267, 10, pid=27649, effective(0, 0), real(0, 0)] ../source3/winbindd/nss_info.c:231(nss_init) nss_init: using 'template' as default backend. [2017/03/26 11:35:13.826271, 10, pid=27649, effective(0, 0), real(0, 0)] ../source3/winbindd/nss_info.c:147(nss_domain_list_add_domain) Added domain '(null)' with backend 'template' to nss_domain_list. [2017/03/26 11:35:13.826275, 10, pid=27649, effective(0, 0), real(0, 0)] ../source3/winbindd/nss_info.c:147(nss_domain_list_add_domain) Added domain 'SAMDOM' with backend 'template' to nss_domain_list. [2017/03/26 11:35:13.826278, 5, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:1259(resolve_alias_to_username) resolve_alias_to_username: backend query returned NT_STATUS_NOT_IMPLEMENTED [2017/03/26 11:35:13.826304, 1, pid=27649, 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 : 'SAMDOM' name : * name : 'ROWLAND' flags : 0x00000008 (8) [2017/03/26 11:35:13.826339, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:4865(wcache_fetch_ndr) Entry has timed out [2017/03/26 11:35:13.850393, 1, pid=27649, 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-1768301897-3342589593-1064908849-1107 result : NT_STATUS_OK [2017/03/26 11:35:13.850431, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/wb_sids2xids.c:113(wb_sids2xids_send) SID 0: S-1-5-21-1768301897-3342589593-1064908849-1107 [2017/03/26 11:35:13.850443, 5, pid=27649, effective(0, 0), real(0, 0), class=tdb] ../source3/lib/gencache.c:69(gencache_init) Opening cache file at /var/cache/samba/gencache.tdb [2017/03/26 11:35:13.850485, 5, pid=27649, effective(0, 0), real(0, 0), class=tdb] ../source3/lib/gencache.c:120(gencache_init) Opening cache file at /var/run/samba/gencache_notrans.tdb [2017/03/26 11:35:13.851293, 10, pid=27649, 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-1768301897-3342589593-1064908849-1107]: value=[10000:U] [2017/03/26 11:35:13.851306, 10, pid=27649, 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-1768301897-3342589593-1064908849-1107]: id=[10000], endptr=[:U] [2017/03/26 11:35:13.851320, 10, pid=27649, effective(0, 0), real(0, 0)] ../source3/libsmb/samlogon_cache.c:242(netsamlogon_cache_get) netsamlogon_cache_get: SID [S-1-5-21-1768301897-3342589593-1064908849-1107] [2017/03/26 11:35:13.851358, 1, pid=27649, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:413(ndr_print_debug) &r: struct netsamlogoncache_entry timestamp : Fri Mar 24 20:17:19 2017 GMT info3: struct netr_SamInfo3 base: struct netr_SamBaseInfo logon_time : Fri Mar 24 20:17:19 2017 GMT logoff_time : Thu Sep 14 03:48:05 30828 BST kickoff_time : Thu Sep 14 03:48:05 30828 BST last_password_change : Mon Nov 9 09:38:21 2015 GMT allow_password_change : Mon Nov 9 09:38:21 2015 GMT force_password_change : Thu Sep 14 03:48:05 30828 BST account_name: struct lsa_String length : 0x000e (14) size : 0x000e (14) string : * string : 'rowland' full_name: struct lsa_String length : 0x001a (26) size : 0x001a (26) string : * string : 'Rowland Penny' 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 : 0x002c (44) size : 0x002c (44) string : * string : '\\MEMBER1\home\rowland' home_drive: struct lsa_String length : 0x0004 (4) size : 0x0004 (4) string : * string : 'H:' logon_count : 0x01ca (458) bad_password_count : 0x0000 (0) rid : 0x00000453 (1107) primary_gid : 0x00000201 (513) groups: struct samr_RidWithAttributeArray count : 0x00000006 (6) rids : * rids: ARRAY(6) rids: struct samr_RidWithAttribute rid : 0x0000044e (1102) 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 : 0x00000477 (1143) 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 : 0x00000480 (1152) 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 : 0x0000084a (2122) 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 : 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 : 0x00000004 (4) 0: NETLOGON_GUEST 0: NETLOGON_NOENCRYPTION 1: 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 : 0x000e (14) size : 0x0010 (16) string : * string : 'MEMBER1' logon_domain: struct lsa_StringLarge length : 0x000c (12) size : 0x000e (14) string : * string : 'SAMDOM' domain_sid : * domain_sid : S-1-5-21-1768301897-3342589593-1064908849 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/03/26 11:35:13.851702, 1, pid=27649, 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 : 'SAMDOM' acct_name : * acct_name : 'rowland' full_name : * full_name : 'Rowland Penny' homedir : * homedir : '/home/%D/%U' shell : * shell : '/bin/false' uid : 0x0000000000002710 (10000) primary_gid : 0x00000000ffffffff (4294967295) primary_group_name : NULL user_sid : S-1-5-21-1768301897-3342589593-1064908849-1107 group_sid : S-1-5-21-1768301897-3342589593-1064908849-513 [2017/03/26 11:35:13.851754, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_dual.c:1419(fork_domain_child) fork_domain_child called without domain. [2017/03/26 11:35:13.852080, 10, pid=27846, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_dual.c:1473(fork_domain_child) Child process 27846 [2017/03/26 11:35:13.852325, 10, pid=27846, effective(0, 0), real(0, 0)] ../source3/lib/messages_dgm_ref.c:157(msg_dgm_ref_destructor) msg_dgm_ref_destructor: refs=0x7efcbf71a9e0 [2017/03/26 11:35:13.852385, 10, pid=27846, effective(0, 0), real(0, 0)] ../source3/lib/messages_dgm_ref.c:79(messaging_dgm_ref) messaging_dgm_ref: messaging_dgm_init returned Success [2017/03/26 11:35:13.852402, 10, pid=27846, effective(0, 0), real(0, 0)] ../source3/lib/messages_dgm_ref.c:108(messaging_dgm_ref) messaging_dgm_ref: unique = 10370283891433301912 [2017/03/26 11:35:14.315616, 1, pid=27649, 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 : 'SAMDOM' acct_name : * acct_name : 'rowland' full_name : * full_name : 'Rowland Penny' homedir : * homedir : '/home/rowland' shell : * shell : '/bin/bash' uid : 0x0000000000002710 (10000) primary_gid : 0x00000000ffffffff (4294967295) primary_group_name : NULL user_sid : S-1-5-21-1768301897-3342589593-1064908849-1107 group_sid : S-1-5-21-1768301897-3342589593-1064908849-513 result : NT_STATUS_OK [2017/03/26 11:35:14.315682, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/wb_sids2xids.c:113(wb_sids2xids_send) SID 0: S-1-5-21-1768301897-3342589593-1064908849-513 [2017/03/26 11:35:14.315701, 10, pid=27649, 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-1768301897-3342589593-1064908849-513]: value=[10000:G] [2017/03/26 11:35:14.315705, 10, pid=27649, 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-1768301897-3342589593-1064908849-513]: id=[10000], endptr=[:G] [2017/03/26 11:35:14.315717, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_util.c:1037(find_lookup_domain_from_sid) find_lookup_domain_from_sid(S-1-5-21-1768301897-3342589593-1064908849-513) [2017/03/26 11:35:14.315723, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_util.c:1047(find_lookup_domain_from_sid) calling find_our_domain [2017/03/26 11:35:14.315731, 1, pid=27649, 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-1768301897-3342589593-1064908849-513 [2017/03/26 11:35:14.315749, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd_cache.c:4865(wcache_fetch_ndr) Entry has timed out [2017/03/26 11:35:14.321775, 1, pid=27649, 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 : 'SAMDOM' name : * name : * name : 'Domain_Users' result : NT_STATUS_OK [2017/03/26 11:35:14.321817, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:796(wb_request_done) wb_request_done[27844:GETPWNAM]: NT_STATUS_OK [2017/03/26 11:35:14.321832, 10, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:864(winbind_client_response_written) winbind_client_response_written[27844:GETPWNAM]: delivered response to client [2017/03/26 11:35:14.321952, 6, pid=27649, effective(0, 0), real(0, 0), class=winbind] ../source3/winbindd/winbindd.c:968(winbind_client_request_read) closing socket 28, client exited