[2021/03/02 17:46:51.432461, 6, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2368(lp_file_list_changed) lp_file_list_changed() file /usr/local/samba/etc/smb.conf -> /usr/local/samba/etc/smb.conf last mod_time: Tue Mar 2 16:23:56 2021 [2021/03/02 17:46:51.432517, 3, pid=592878, effective(0, 0), real(0, 0), class=locking] ../../source3/smbd/oplock.c:1427(init_oplocks) init_oplocks: initializing messages. [2021/03/02 17:46:51.432536, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 774 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432553, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 778 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432566, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 770 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432581, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 801 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432595, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 787 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432610, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 779 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432625, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 15 - private_data=(nil) [2021/03/02 17:46:51.432637, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:739(messaging_register) Overriding messaging pointer for type 15 - private_data=(nil) [2021/03/02 17:46:51.432654, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:771(messaging_deregister) Deregistering messaging pointer for type 16 - private_data=(nil) [2021/03/02 17:46:51.432669, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 16 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432682, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:771(messaging_deregister) Deregistering messaging pointer for type 33 - private_data=0x564b5f525300 [2021/03/02 17:46:51.432696, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 33 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432709, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:771(messaging_deregister) Deregistering messaging pointer for type 790 - private_data=(nil) [2021/03/02 17:46:51.432723, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 790 - private_data=0x564b5f542110 [2021/03/02 17:46:51.432739, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:771(messaging_deregister) Deregistering messaging pointer for type 791 - private_data=(nil) [2021/03/02 17:46:51.432753, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:771(messaging_deregister) Deregistering messaging pointer for type 1 - private_data=(nil) [2021/03/02 17:46:51.432767, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:723(messaging_register) Registering messaging pointer for type 1 - private_data=(nil) [2021/03/02 17:46:51.432788, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/util_event.c:100(event_add_idle) event_add_idle: idle_evt(keepalive) 0x564b5f525560 [2021/03/02 17:46:51.432806, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/util_event.c:100(event_add_idle) event_add_idle: idle_evt(deadtime) 0x564b5f5178c0 [2021/03/02 17:46:51.432827, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/util_event.c:100(event_add_idle) event_add_idle: idle_evt(housekeeping) 0x564b5f544a90 [2021/03/02 17:46:51.432890, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive) got smb length of 210 [2021/03/02 17:46:51.432908, 6, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1954(process_smb) got message type 0x0 of len 0xd2 [2021/03/02 17:46:51.432922, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1956(process_smb) Transaction 0 of length 214 (0 toread) [2021/03/02 17:46:51.432934, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:4449(smbd_smb2_process_negprot) smbd_smb2_first_negprot: packet length 210 [2021/03/02 17:46:51.432967, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 0 (position 0) from bitmap [2021/03/02 17:46:51.432985, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_NEGPROT] mid = 0 [2021/03/02 17:46:51.433007, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.433028, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.433048, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.433080, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.433110, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.433129, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.433143, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.433157, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.433169, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.433216, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.433230, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:1208(set_remote_arch) set_remote_arch: Client arch is 'Vista' [2021/03/02 17:46:51.433253, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:811(debug_dump_status) INFO: Current debug levels: all: 10 tdb: 10 printdrivers: 10 lanman: 10 smb: 10 rpc_parse: 10 rpc_srv: 10 rpc_cli: 10 passdb: 10 sam: 10 auth: 10 winbind: 10 vfs: 10 idmap: 10 quota: 10 acls: 10 locking: 10 msdfs: 10 dmapi: 10 registry: 10 scavenger: 10 dns: 10 ldb: 10 tevent: 10 auth_audit: 10 auth_json_audit: 10 kerberos: 10 drs_repl: 10 smb2: 10 smb2_credits: 10 dsdb_audit: 10 dsdb_json_audit: 10 dsdb_password_audit: 10 dsdb_password_json_audit: 10 dsdb_transaction_audit: 10 dsdb_transaction_json_audit: 10 dsdb_group_audit: 10 dsdb_group_json_audit: 10 [2021/03/02 17:46:51.433479, 6, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2368(lp_file_list_changed) lp_file_list_changed() file /usr/local/samba/etc/smb.conf -> /usr/local/samba/etc/smb.conf last mod_time: Tue Mar 2 16:23:56 2021 [2021/03/02 17:46:51.433511, 3, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_negprot.c:293(smbd_smb2_request_process_negprot) Selected protocol SMB3_11 [2021/03/02 17:46:51.433532, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:550(make_auth3_context_for_ntlm) Making default auth method list for server role = 'standalone server', encrypt passwords = yes [2021/03/02 17:46:51.433559, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend anonymous [2021/03/02 17:46:51.433578, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'anonymous' [2021/03/02 17:46:51.433593, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend name_to_ntstatus [2021/03/02 17:46:51.433607, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'name_to_ntstatus' [2021/03/02 17:46:51.433621, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend sam [2021/03/02 17:46:51.433635, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'sam' [2021/03/02 17:46:51.433648, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend sam_ignoredomain [2021/03/02 17:46:51.433661, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'sam_ignoredomain' [2021/03/02 17:46:51.433673, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend sam_netlogon3 [2021/03/02 17:46:51.433685, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'sam_netlogon3' [2021/03/02 17:46:51.433697, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend winbind [2021/03/02 17:46:51.433710, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'winbind' [2021/03/02 17:46:51.433723, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend unix [2021/03/02 17:46:51.433736, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'unix' [2021/03/02 17:46:51.433748, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth) Attempting to register auth backend samba4 [2021/03/02 17:46:51.433766, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth) Successfully added auth method 'samba4' [2021/03/02 17:46:51.433779, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:425(load_auth_module) load_auth_module: Attempting to find an auth method to match anonymous [2021/03/02 17:46:51.433793, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:450(load_auth_module) load_auth_module: auth method anonymous has a valid init [2021/03/02 17:46:51.433810, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:425(load_auth_module) load_auth_module: Attempting to find an auth method to match sam_ignoredomain [2021/03/02 17:46:51.433826, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:450(load_auth_module) load_auth_module: auth method sam_ignoredomain has a valid init [2021/03/02 17:46:51.441822, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'gssapi_spnego' registered [2021/03/02 17:46:51.441846, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'gssapi_krb5' registered [2021/03/02 17:46:51.441861, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'gssapi_krb5_sasl' registered [2021/03/02 17:46:51.441875, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'spnego' registered [2021/03/02 17:46:51.441890, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'schannel' registered [2021/03/02 17:46:51.441905, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'naclrpc_as_system' registered [2021/03/02 17:46:51.441920, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'sasl-EXTERNAL' registered [2021/03/02 17:46:51.441935, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'ntlmssp' registered [2021/03/02 17:46:51.441951, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'ntlmssp_resume_ccache' registered [2021/03/02 17:46:51.441966, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'http_basic' registered [2021/03/02 17:46:51.441981, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'http_ntlm' registered [2021/03/02 17:46:51.441996, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'http_negotiate' registered [2021/03/02 17:46:51.442013, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'krb5' registered [2021/03/02 17:46:51.442027, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:1088(gensec_register) GENSEC backend 'fake_gssapi_krb5' registered [2021/03/02 17:46:51.442125, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:849(gensec_start_mech) Starting GENSEC mechanism spnego [2021/03/02 17:46:51.442194, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:849(gensec_start_mech) Starting GENSEC submechanism ntlmssp [2021/03/02 17:46:51.442239, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send) gensec_update_send: spnego[0x564b5f555c00]: subreq: 0x564b5f55a4b0 [2021/03/02 17:46:51.442259, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:547(gensec_update_done) gensec_update_done: spnego[0x564b5f555c00]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x564b5f55a4b0/../../auth/gensec/spnego.c:1631]: state[2] error[0 (0x0)] state[struct gensec_spnego_update_state (0x564b5f55a660)] timer[(nil)] finish[../../auth/gensec/spnego.c:2116] [2021/03/02 17:46:51.442324, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [0] idx[1] status[NT_STATUS_OK] body[64] dyn[yes:140] at ../../source3/smbd/smb2_negprot.c:667 [2021/03/02 17:46:51.442353, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 31, charge 1, granted 1, current possible/max 8192/8192, total granted/max/low/range 1/8192/1/1 [2021/03/02 17:46:51.445399, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.445419, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 1 (position 1) from bitmap [2021/03/02 17:46:51.445434, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_SESSSETUP] mid = 1 [2021/03/02 17:46:51.445450, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.445465, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.445479, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.445504, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.445536, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.445557, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_session_global.tdb 2: 3: 4: [2021/03/02 17:46:51.445575, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 28E211F9 [2021/03/02 17:46:51.445597, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f547f70 [2021/03/02 17:46:51.445636, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:452(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: No watchers [2021/03/02 17:46:51.445677, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:949(smbXsrv_session_global_store) [2021/03/02 17:46:51.445689, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:950(smbXsrv_session_global_store) smbXsrv_session_global_store: key '28E211F9' stored [2021/03/02 17:46:51.445703, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_session_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000001 (1) info : union smbXsrv_session_globalU(case 0) info0 : * info0: struct smbXsrv_session_global0 db_rec : * session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) [2021/03/02 17:46:51.445948, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.445962, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 28E211F9 [2021/03/02 17:46:51.445976, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1325(smbXsrv_session_create) [2021/03/02 17:46:51.445986, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1331(smbXsrv_session_create) smbXsrv_session_create: global_id (0x28e211f9) stored [2021/03/02 17:46:51.445999, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &session_blob: struct smbXsrv_sessionB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_sessionU(case 0) info0 : * info0: struct smbXsrv_session table : * db_rec : NULL client : * local_id : 0x28e211f9 (685904377) global : * global: struct smbXsrv_session_global0 db_rec : NULL session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) status : NT_STATUS_MORE_PROCESSING_REQUIRED idle_time : Tue Mar 2 05:46:51 PM 2021 PST nonce_high_random : 0x0000000000000000 (0) nonce_high_max : 0x0000000000000000 (0) nonce_high : 0x0000000000000000 (0) nonce_low : 0x0000000000000000 (0) tcon_table : * homes_snum : 0xffffffff (4294967295) pending_auth : NULL [2021/03/02 17:46:51.446338, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:550(make_auth3_context_for_ntlm) Making default auth method list for server role = 'standalone server', encrypt passwords = yes [2021/03/02 17:46:51.446363, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:425(load_auth_module) load_auth_module: Attempting to find an auth method to match anonymous [2021/03/02 17:46:51.446379, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:450(load_auth_module) load_auth_module: auth method anonymous has a valid init [2021/03/02 17:46:51.446394, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:425(load_auth_module) load_auth_module: Attempting to find an auth method to match sam_ignoredomain [2021/03/02 17:46:51.446409, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:450(load_auth_module) load_auth_module: auth method sam_ignoredomain has a valid init [2021/03/02 17:46:51.446490, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:849(gensec_start_mech) Starting GENSEC mechanism spnego [2021/03/02 17:46:51.446507, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.446525, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_session_global.tdb 2: 3: 4: [2021/03/02 17:46:51.446543, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 28E211F9 [2021/03/02 17:46:51.446558, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f53a930 [2021/03/02 17:46:51.446586, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:452(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: No watchers [2021/03/02 17:46:51.446603, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:949(smbXsrv_session_global_store) [2021/03/02 17:46:51.446613, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:950(smbXsrv_session_global_store) smbXsrv_session_global_store: key '28E211F9' stored [2021/03/02 17:46:51.446627, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_session_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000002 (2) info : union smbXsrv_session_globalU(case 0) info0 : * info0: struct smbXsrv_session_global0 db_rec : * session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) [2021/03/02 17:46:51.447751, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.447768, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 28E211F9 [2021/03/02 17:46:51.447782, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1422(smbXsrv_session_update) [2021/03/02 17:46:51.447792, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1428(smbXsrv_session_update) smbXsrv_session_update: global_id (0x28e211f9) stored [2021/03/02 17:46:51.447804, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &session_blob: struct smbXsrv_sessionB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_sessionU(case 0) info0 : * info0: struct smbXsrv_session table : * db_rec : NULL client : * local_id : 0x28e211f9 (685904377) global : * global: struct smbXsrv_session_global0 db_rec : NULL session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x00 (0) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 0: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x00 (0) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) status : NT_STATUS_MORE_PROCESSING_REQUIRED idle_time : Tue Mar 2 05:46:51 PM 2021 PST nonce_high_random : 0x0000000000000000 (0) nonce_high_max : 0x0000000000000000 (0) nonce_high : 0x0000000000000000 (0) nonce_low : 0x0000000000000000 (0) tcon_table : * homes_snum : 0xffffffff (4294967295) pending_auth : * pending_auth: struct smbXsrv_session_auth0 prev : * next : NULL session : * connection : * gensec : * preauth : * in_flags : 0x00 (0) in_security_mode : 0x01 (1) creation_time : Tue Mar 2 05:46:51 PM 2021 PST idle_time : Tue Mar 2 05:46:51 PM 2021 PST channel_id : 0x0000000000000000 (0) [2021/03/02 17:46:51.448205, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.448219, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.448233, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.448246, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.448259, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.448334, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec_start.c:849(gensec_start_mech) Starting GENSEC submechanism ntlmssp [2021/03/02 17:46:51.448356, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0x62088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2021/03/02 17:46:51.448645, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) negotiate: struct NEGOTIATE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmNegotiate (1) NegotiateFlags : 0x62088215 (1644724757) 1: NTLMSSP_NEGOTIATE_UNICODE 0: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 0: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 0: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 0: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 0: NTLMSSP_NEGOTIATE_56 DomainNameLen : 0x0000 (0) DomainNameMaxLen : 0x0000 (0) DomainName : * DomainName : '' WorkstationLen : 0x0000 (0) WorkstationMaxLen : 0x0000 (0) Workstation : * Workstation : '' Version: struct ntlmssp_VERSION ProductMajorVersion : NTLMSSP_WINDOWS_MAJOR_VERSION_6 (6) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_1 (1) ProductBuild : 0x0000 (0) Reserved: ARRAY(3) [0] : 0x00 (0) [1] : 0x00 (0) [2] : 0x00 (0) NTLMRevisionCurrent : NTLMSSP_REVISION_W2K3 (15) [2021/03/02 17:46:51.448929, 6, pid=592878, effective(0, 0), real(0, 0)] ../../librpc/ndr/ndr_string.c:178(ndr_pull_string) short string '', sent with NULL termination despite NOTERM flag in IDL [2021/03/02 17:46:51.448951, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) challenge: struct CHALLENGE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmChallenge (0x2) TargetNameLen : 0x0018 (24) TargetNameMaxLen : 0x0018 (24) TargetName : * TargetName : 'JEREMY-ACERB' NegotiateFlags : 0x628a8215 (1653244437) 1: NTLMSSP_NEGOTIATE_UNICODE 0: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 0: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 1: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 1: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 0: NTLMSSP_NEGOTIATE_56 ServerChallenge : 2889ce1dd5f66a5c Reserved : 0000000000000000 TargetInfoLen : 0x0068 (104) TargetInfoMaxLen : 0x0068 (104) TargetInfo : * TargetInfo: struct AV_PAIR_LIST count : 0x00000006 (6) pair: ARRAY(6) pair: struct AV_PAIR AvId : MsvAvNbDomainName (0x2) AvLen : 0x0018 (24) Value : union ntlmssp_AvValue(case 0x2) AvNbDomainName : 'JEREMY-ACERB' pair: struct AV_PAIR AvId : MsvAvNbComputerName (0x1) AvLen : 0x0018 (24) Value : union ntlmssp_AvValue(case 0x1) AvNbComputerName : 'JEREMY-ACERB' pair: struct AV_PAIR AvId : MsvAvDnsDomainName (0x4) AvLen : 0x0002 (2) Value : union ntlmssp_AvValue(case 0x4) AvDnsDomainName : '' pair: struct AV_PAIR AvId : MsvAvDnsComputerName (0x3) AvLen : 0x0016 (22) Value : union ntlmssp_AvValue(case 0x3) AvDnsComputerName : 'jeremy-acer' pair: struct AV_PAIR AvId : MsvAvTimestamp (0x7) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x7) AvTimestamp : Tue Mar 2 05:46:51 PM 2021 PST pair: struct AV_PAIR AvId : MsvAvEOL (0x0) AvLen : 0x0000 (0) Value : union ntlmssp_AvValue(case 0x0) Version: struct ntlmssp_VERSION ProductMajorVersion : NTLMSSP_WINDOWS_MAJOR_VERSION_6 (0x6) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_1 (0x1) ProductBuild : 0x0000 (0) Reserved : 000000 NTLMRevisionCurrent : NTLMSSP_REVISION_W2K3 (0xF) [2021/03/02 17:46:51.449330, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send) gensec_update_send: ntlmssp[0x564b5f559f80]: subreq: 0x564b5f546060 [2021/03/02 17:46:51.449346, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send) gensec_update_send: spnego[0x564b5f56bd40]: subreq: 0x564b5f578030 [2021/03/02 17:46:51.449368, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.449399, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:547(gensec_update_done) gensec_update_done: ntlmssp[0x564b5f559f80]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x564b5f546060/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)] state[struct gensec_ntlmssp_update_state (0x564b5f546210)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:215] [2021/03/02 17:46:51.449433, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:547(gensec_update_done) gensec_update_done: spnego[0x564b5f56bd40]: NT_STATUS_MORE_PROCESSING_REQUIRED tevent_req[0x564b5f578030/../../auth/gensec/spnego.c:1631]: state[2] error[0 (0x0)] state[struct gensec_spnego_update_state (0x564b5f5781e0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2116] [2021/03/02 17:46:51.449452, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.449466, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.449479, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.449492, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.449508, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.449538, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.449555, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:3758(smbd_smb2_request_done_ex) smbd_smb2_request_done_ex: mid [1] idx[1] status[NT_STATUS_MORE_PROCESSING_REQUIRED] body[8] dyn[yes:215] at ../../source3/smbd/smb2_sesssetup.c:183 [2021/03/02 17:46:51.449573, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:969(smb2_set_operation_credit) smb2_set_operation_credit: smb2_set_operation_credit: requested 8192, charge 1, granted 1, current possible/max 8192/8192, total granted/max/low/range 1/8192/2/1 [2021/03/02 17:46:51.451498, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:4900(smbd_smb2_io_handler) smbd_smb2_request idx[1] of 5 vectors [2021/03/02 17:46:51.451517, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2_credits] ../../source3/smbd/smb2_server.c:712(smb2_validate_sequence_number) smb2_validate_sequence_number: smb2_validate_sequence_number: clearing id 2 (position 2) from bitmap [2021/03/02 17:46:51.451532, 10, pid=592878, effective(0, 0), real(0, 0), class=smb2] ../../source3/smbd/smb2_server.c:2916(smbd_smb2_request_dispatch) smbd_smb2_request_dispatch: opcode[SMB2_OP_SESSSETUP] mid = 2 [2021/03/02 17:46:51.451548, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.451561, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_session_global.tdb 2: 3: 4: [2021/03/02 17:46:51.451577, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 28E211F9 [2021/03/02 17:46:51.451592, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f53a930 [2021/03/02 17:46:51.451617, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:452(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: No watchers [2021/03/02 17:46:51.451634, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:949(smbXsrv_session_global_store) [2021/03/02 17:46:51.451645, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:950(smbXsrv_session_global_store) smbXsrv_session_global_store: key '28E211F9' stored [2021/03/02 17:46:51.451660, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_session_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000003 (3) info : union smbXsrv_session_globalU(case 0) info0 : * info0: struct smbXsrv_session_global0 db_rec : * session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) [2021/03/02 17:46:51.451904, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.451920, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 28E211F9 [2021/03/02 17:46:51.451934, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1422(smbXsrv_session_update) [2021/03/02 17:46:51.451944, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1428(smbXsrv_session_update) smbXsrv_session_update: global_id (0x28e211f9) stored [2021/03/02 17:46:51.451956, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &session_blob: struct smbXsrv_sessionB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_sessionU(case 0) info0 : * info0: struct smbXsrv_session table : * db_rec : NULL client : * local_id : 0x28e211f9 (685904377) global : * global: struct smbXsrv_session_global0 db_rec : NULL session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) status : NT_STATUS_MORE_PROCESSING_REQUIRED idle_time : Tue Mar 2 05:46:51 PM 2021 PST nonce_high_random : 0x0000000000000000 (0) nonce_high_max : 0x0000000000000000 (0) nonce_high : 0x0000000000000000 (0) nonce_low : 0x0000000000000000 (0) tcon_table : * homes_snum : 0xffffffff (4294967295) pending_auth : * pending_auth: struct smbXsrv_session_auth0 prev : * next : NULL session : * connection : * gensec : * preauth : * in_flags : 0x00 (0) in_security_mode : 0x01 (1) creation_time : Tue Mar 2 05:46:51 PM 2021 PST idle_time : Tue Mar 2 05:46:51 PM 2021 PST channel_id : 0x0000000000000000 (0) [2021/03/02 17:46:51.452352, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.452366, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.452379, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.452401, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:493(smbd_change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2021/03/02 17:46:51.452422, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_lock) dbwrap_lock_order_lock: check lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.452441, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:131(debug_lock_order) lock order: 1:/usr/local/samba/var/lock/smbXsrv_session_global.tdb 2: 3: 4: [2021/03/02 17:46:51.452458, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Locking key 28E211F9 [2021/03/02 17:46:51.452472, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal) db_tdb_fetch_locked_internal: Allocated locked data 0x564b5f53a930 [2021/03/02 17:46:51.452499, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/dbwrap/dbwrap_watch.c:452(dbwrap_watched_subrec_wakeup_fn) dbwrap_watched_subrec_wakeup_fn: No watchers [2021/03/02 17:46:51.452516, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:949(smbXsrv_session_global_store) [2021/03/02 17:46:51.452525, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:950(smbXsrv_session_global_store) smbXsrv_session_global_store: key '28E211F9' stored [2021/03/02 17:46:51.452537, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &global_blob: struct smbXsrv_session_globalB version : SMBXSRV_VERSION_0 (0) seqnum : 0x00000004 (4) info : union smbXsrv_session_globalU(case 0) info0 : * info0: struct smbXsrv_session_global0 db_rec : * session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) [2021/03/02 17:46:51.452765, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:178(dbwrap_lock_order_unlock) dbwrap_lock_order_unlock: release lock order 1 for /usr/local/samba/var/lock/smbXsrv_session_global.tdb [2021/03/02 17:46:51.452781, 10, pid=592878, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key) db_tdb_log_key: Unlocking key 28E211F9 [2021/03/02 17:46:51.452795, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1422(smbXsrv_session_update) [2021/03/02 17:46:51.452804, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1428(smbXsrv_session_update) smbXsrv_session_update: global_id (0x28e211f9) stored [2021/03/02 17:46:51.452816, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &session_blob: struct smbXsrv_sessionB version : SMBXSRV_VERSION_0 (0) reserved : 0x00000000 (0) info : union smbXsrv_sessionU(case 0) info0 : * info0: struct smbXsrv_session table : * db_rec : NULL client : * local_id : 0x28e211f9 (685904377) global : * global: struct smbXsrv_session_global0 db_rec : NULL session_global_id : 0x28e211f9 (685904377) session_wire_id : 0x0000000028e211f9 (685904377) creation_time : Tue Mar 2 05:46:51 PM 2021 PST expiration_time : Wed Sep 13 07:48:05 PM 30828 PDT auth_time : NTTIME(0) auth_session_info_seqnum : 0x00000000 (0) auth_session_info : NULL connection_dialect : 0x0311 (785) signing_flags : 0x04 (4) 0: SMBXSRV_SIGNING_REQUIRED 0: SMBXSRV_PROCESSED_SIGNED_PACKET 1: SMBXSRV_PROCESSED_UNSIGNED_PACKET encryption_flags : 0x08 (8) 0: SMBXSRV_ENCRYPTION_REQUIRED 0: SMBXSRV_ENCRYPTION_DESIRED 0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET 1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET signing_key : NULL encryption_key : NULL decryption_key : NULL num_channels : 0x00000001 (1) channels: ARRAY(1) channels: struct smbXsrv_channel_global0 server_id: struct server_id pid : 0x0000000000090bee (592878) task_id : 0x00000000 (0) vnn : 0xffffffff (4294967295) unique_id : 0x1a9d5632e20f54a9 (1917783792870708393) channel_id : 0x0000000000000000 (0) creation_time : Tue Mar 2 05:46:51 PM 2021 PST local_address : 'ipv4:127.0.0.1:445' remote_address : 'ipv4:127.0.0.1:46096' remote_name : '127.0.0.1' signing_key : NULL auth_session_info_seqnum : 0x00000000 (0) connection : * encryption_cipher : 0x0000 (0) status : NT_STATUS_MORE_PROCESSING_REQUIRED idle_time : Tue Mar 2 05:46:51 PM 2021 PST nonce_high_random : 0x0000000000000000 (0) nonce_high_max : 0x0000000000000000 (0) nonce_high : 0x0000000000000000 (0) nonce_low : 0x0000000000000000 (0) tcon_table : * homes_snum : 0xffffffff (4294967295) pending_auth : * pending_auth: struct smbXsrv_session_auth0 prev : * next : NULL session : * connection : * gensec : * preauth : * in_flags : 0x00 (0) in_security_mode : 0x01 (1) creation_time : Tue Mar 2 05:46:51 PM 2021 PST idle_time : Tue Mar 2 05:46:51 PM 2021 PST channel_id : 0x0000000000000000 (0) [2021/03/02 17:46:51.453215, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.453231, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.453244, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.453257, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.453270, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.453326, 6, pid=592878, effective(0, 0), real(0, 0)] ../../librpc/ndr/ndr_string.c:178(ndr_pull_string) short string '', sent with NULL termination despite NOTERM flag in IDL [2021/03/02 17:46:51.453357, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) authenticate: struct AUTHENTICATE_MESSAGE Signature : 'NTLMSSP' MessageType : NtLmAuthenticate (3) LmChallengeResponseLen : 0x0018 (24) LmChallengeResponseMaxLen: 0x0018 (24) LmChallengeResponse : * LmChallengeResponse : union ntlmssp_LM_RESPONSE_with_len(case 24) v1: struct LM_RESPONSE Response : 000000000000000000000000000000000000000000000000 NtChallengeResponseLen : 0x0104 (260) NtChallengeResponseMaxLen: 0x0104 (260) NtChallengeResponse : * NtChallengeResponse : union ntlmssp_NTLM_RESPONSE_with_len(case 260) v2: struct NTLMv2_RESPONSE Response : 276c9a481e94bc8fd6487bc8bf833479 Challenge: struct NTLMv2_CLIENT_CHALLENGE RespType : 0x01 (1) HiRespType : 0x01 (1) Reserved1 : 0x0000 (0) Reserved2 : 0x00000000 (0) TimeStamp : Tue Mar 2 05:46:51 PM 2021 PST ChallengeFromClient : 57002d03437dd2fc Reserved3 : 0x00000000 (0) AvPairs: struct AV_PAIR_LIST count : 0x0000000a (10) pair: ARRAY(10) pair: struct AV_PAIR AvId : MsvAvNbDomainName (0x2) AvLen : 0x0018 (24) Value : union ntlmssp_AvValue(case 0x2) AvNbDomainName : 'JEREMY-ACERB' pair: struct AV_PAIR AvId : MsvAvNbComputerName (0x1) AvLen : 0x0018 (24) Value : union ntlmssp_AvValue(case 0x1) AvNbComputerName : 'JEREMY-ACERB' pair: struct AV_PAIR AvId : MsvAvDnsDomainName (0x4) AvLen : 0x0002 (2) Value : union ntlmssp_AvValue(case 0x4) AvDnsDomainName : '' pair: struct AV_PAIR AvId : MsvAvDnsComputerName (0x3) AvLen : 0x0016 (22) Value : union ntlmssp_AvValue(case 0x3) AvDnsComputerName : 'jeremy-acer' pair: struct AV_PAIR AvId : MsvAvTimestamp (0x7) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x7) AvTimestamp : Tue Mar 2 05:46:51 PM 2021 PST pair: struct AV_PAIR AvId : MsvAvFlags (0x6) AvLen : 0x0004 (4) Value : union ntlmssp_AvValue(case 0x6) AvFlags : 0x00000002 (2) 0: NTLMSSP_AVFLAG_CONSTRAINTED_ACCOUNT 1: NTLMSSP_AVFLAG_MIC_IN_AUTHENTICATE_MESSAGE 0: NTLMSSP_AVFLAG_TARGET_SPN_FROM_UNTRUSTED_SOURCE pair: struct AV_PAIR AvId : MsvAvSingleHost (0x8) AvLen : 0x0030 (48) Value : union ntlmssp_AvValue(case 0x8) AvSingleHost: struct ntlmssp_SingleHostData Size : 0x00000030 (48) Z4 : 0x00000000 (0) token_info: struct LSAP_TOKEN_INFO_INTEGRITY Flags : 0x00000000 (0) TokenIL : 0x00000000 (0) MachineId : f1cfb2d50640c84913dbea8115ecb52366b1a73e9d01d7b534b105c8fc2e05e0 remaining : DATA_BLOB length=0 pair: struct AV_PAIR AvId : MsvChannelBindings (0xA) AvLen : 0x0010 (16) Value : union ntlmssp_AvValue(case 0xA) ChannelBindings : 00000000000000000000000000000000 pair: struct AV_PAIR AvId : MsvAvTargetName (0x9) AvLen : 0x001c (28) Value : union ntlmssp_AvValue(case 0x9) AvTargetName : 'cifs/127.0.0.1' pair: struct AV_PAIR AvId : MsvAvEOL (0x0) AvLen : 0x0000 (0) Value : union ntlmssp_AvValue(case 0x0) DomainNameLen : 0x0012 (18) DomainNameMaxLen : 0x0012 (18) DomainName : * DomainName : 'WORKGROUP' UserNameLen : 0x000c (12) UserNameMaxLen : 0x000c (12) UserName : * UserName : 'jeremy' WorkstationLen : 0x0018 (24) WorkstationMaxLen : 0x0018 (24) Workstation : * Workstation : 'JEREMY-ACERB' EncryptedRandomSessionKeyLen: 0x0010 (16) EncryptedRandomSessionKeyMaxLen: 0x0010 (16) EncryptedRandomSessionKey: * EncryptedRandomSessionKey: DATA_BLOB length=16 [0000] D5 10 8B 64 0E A9 48 6A 0F BE 36 B3 83 5A 12 0A ...d..Hj ..6..Z.. NegotiateFlags : 0x62088215 (1644724757) 1: NTLMSSP_NEGOTIATE_UNICODE 0: NTLMSSP_NEGOTIATE_OEM 1: NTLMSSP_REQUEST_TARGET 1: NTLMSSP_NEGOTIATE_SIGN 0: NTLMSSP_NEGOTIATE_SEAL 0: NTLMSSP_NEGOTIATE_DATAGRAM 0: NTLMSSP_NEGOTIATE_LM_KEY 0: NTLMSSP_NEGOTIATE_NETWARE 1: NTLMSSP_NEGOTIATE_NTLM 0: NTLMSSP_NEGOTIATE_NT_ONLY 0: NTLMSSP_ANONYMOUS 0: NTLMSSP_NEGOTIATE_OEM_DOMAIN_SUPPLIED 0: NTLMSSP_NEGOTIATE_OEM_WORKSTATION_SUPPLIED 0: NTLMSSP_NEGOTIATE_THIS_IS_LOCAL_CALL 1: NTLMSSP_NEGOTIATE_ALWAYS_SIGN 0: NTLMSSP_TARGET_TYPE_DOMAIN 0: NTLMSSP_TARGET_TYPE_SERVER 0: NTLMSSP_TARGET_TYPE_SHARE 1: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY 0: NTLMSSP_NEGOTIATE_IDENTIFY 0: NTLMSSP_REQUEST_NON_NT_SESSION_KEY 0: NTLMSSP_NEGOTIATE_TARGET_INFO 1: NTLMSSP_NEGOTIATE_VERSION 1: NTLMSSP_NEGOTIATE_128 1: NTLMSSP_NEGOTIATE_KEY_EXCH 0: NTLMSSP_NEGOTIATE_56 Version: struct ntlmssp_VERSION ProductMajorVersion : NTLMSSP_WINDOWS_MAJOR_VERSION_6 (6) ProductMinorVersion : NTLMSSP_WINDOWS_MINOR_VERSION_1 (1) ProductBuild : 0x0000 (0) Reserved: ARRAY(3) [0] : 0x00 (0) [1] : 0x00 (0) [2] : 0x00 (0) NTLMRevisionCurrent : NTLMSSP_REVISION_W2K3 (15) [2021/03/02 17:46:51.454100, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_server.c:509(ntlmssp_server_preauth) Got user=[jeremy] domain=[WORKGROUP] workstation=[JEREMY-ACERB] len1=24 len2=260 [2021/03/02 17:46:51.454121, 6, pid=592878, effective(0, 0), real(0, 0)] ../../librpc/ndr/ndr_string.c:178(ndr_pull_string) short string '', sent with NULL termination despite NOTERM flag in IDL [2021/03/02 17:46:51.454143, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_server.c:544(ntlmssp_server_preauth) [2021/03/02 17:46:51.454154, 1, pid=592878, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:429(ndr_print_debug) &v2_resp: struct NTLMv2_RESPONSE Response : 276c9a481e94bc8fd6487bc8bf833479 Challenge: struct NTLMv2_CLIENT_CHALLENGE RespType : 0x01 (1) HiRespType : 0x01 (1) Reserved1 : 0x0000 (0) Reserved2 : 0x00000000 (0) TimeStamp : Tue Mar 2 05:46:51 PM 2021 PST ChallengeFromClient : 57002d03437dd2fc Reserved3 : 0x00000000 (0) AvPairs: struct AV_PAIR_LIST count : 0x0000000a (10) pair: ARRAY(10) pair: struct AV_PAIR AvId : MsvAvNbDomainName (0x2) AvLen : 0x0018 (24) Value : union ntlmssp_AvValue(case 0x2) AvNbDomainName : 'JEREMY-ACERB' pair: struct AV_PAIR AvId : MsvAvNbComputerName (0x1) AvLen : 0x0018 (24) Value : union ntlmssp_AvValue(case 0x1) AvNbComputerName : 'JEREMY-ACERB' pair: struct AV_PAIR AvId : MsvAvDnsDomainName (0x4) AvLen : 0x0002 (2) Value : union ntlmssp_AvValue(case 0x4) AvDnsDomainName : '' pair: struct AV_PAIR AvId : MsvAvDnsComputerName (0x3) AvLen : 0x0016 (22) Value : union ntlmssp_AvValue(case 0x3) AvDnsComputerName : 'jeremy-acer' pair: struct AV_PAIR AvId : MsvAvTimestamp (0x7) AvLen : 0x0008 (8) Value : union ntlmssp_AvValue(case 0x7) AvTimestamp : Tue Mar 2 05:46:51 PM 2021 PST pair: struct AV_PAIR AvId : MsvAvFlags (0x6) AvLen : 0x0004 (4) Value : union ntlmssp_AvValue(case 0x6) AvFlags : 0x00000002 (2) 0: NTLMSSP_AVFLAG_CONSTRAINTED_ACCOUNT 1: NTLMSSP_AVFLAG_MIC_IN_AUTHENTICATE_MESSAGE 0: NTLMSSP_AVFLAG_TARGET_SPN_FROM_UNTRUSTED_SOURCE pair: struct AV_PAIR AvId : MsvAvSingleHost (0x8) AvLen : 0x0030 (48) Value : union ntlmssp_AvValue(case 0x8) AvSingleHost: struct ntlmssp_SingleHostData Size : 0x00000030 (48) Z4 : 0x00000000 (0) token_info: struct LSAP_TOKEN_INFO_INTEGRITY Flags : 0x00000000 (0) TokenIL : 0x00000000 (0) MachineId : f1cfb2d50640c84913dbea8115ecb52366b1a73e9d01d7b534b105c8fc2e05e0 remaining : DATA_BLOB length=0 pair: struct AV_PAIR AvId : MsvChannelBindings (0xA) AvLen : 0x0010 (16) Value : union ntlmssp_AvValue(case 0xA) ChannelBindings : 00000000000000000000000000000000 pair: struct AV_PAIR AvId : MsvAvTargetName (0x9) AvLen : 0x001c (28) Value : union ntlmssp_AvValue(case 0x9) AvTargetName : 'cifs/127.0.0.1' pair: struct AV_PAIR AvId : MsvAvEOL (0x0) AvLen : 0x0000 (0) Value : union ntlmssp_AvValue(case 0x0) [2021/03/02 17:46:51.454567, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:123(make_user_info_map) Mapping user [WORKGROUP]\[jeremy] from workstation [JEREMY-ACERB] [2021/03/02 17:46:51.454583, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:64(make_user_info) attempting to make a user_info for jeremy (jeremy) [2021/03/02 17:46:51.454596, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:72(make_user_info) making strings for jeremy's user_info struct [2021/03/02 17:46:51.454613, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:117(make_user_info) making blobs for jeremy's user_info struct [2021/03/02 17:46:51.454628, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:163(make_user_info) made a user_info for jeremy (jeremy) [2021/03/02 17:46:51.454643, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:201(auth_check_ntlm_password) check_ntlm_password: Checking password for unmapped user [WORKGROUP]\[jeremy]@[JEREMY-ACERB] with the new password interface [2021/03/02 17:46:51.454657, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:204(auth_check_ntlm_password) check_ntlm_password: mapped user is: [WORKGROUP]\[jeremy]@[JEREMY-ACERB] [2021/03/02 17:46:51.454671, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:214(auth_check_ntlm_password) check_ntlm_password: auth_context challenge created by random [2021/03/02 17:46:51.454684, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:217(auth_check_ntlm_password) challenge is: [2021/03/02 17:46:51.454696, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/util.c:570(dump_data) [0000] 28 89 CE 1D D5 F6 6A 5C (.....j\ [2021/03/02 17:46:51.454718, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_builtin.c:42(check_anonymous_security) Check auth for: [jeremy] [2021/03/02 17:46:51.454731, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:250(auth_check_ntlm_password) auth_check_ntlm_password: anonymous had nothing to say [2021/03/02 17:46:51.454744, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_sam.c:46(auth_sam_ignoredomain_auth) auth_sam_ignoredomain_auth: Check auth for: [WORKGROUP]\[jeremy] [2021/03/02 17:46:51.454763, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.454778, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.454790, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.454803, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.454873, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.454917, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:572(pdb_set_username) pdb_set_username: setting username jeremy, was [2021/03/02 17:46:51.454933, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:595(pdb_set_domain) pdb_set_domain: setting domain JEREMY-ACERB, was [2021/03/02 17:46:51.454947, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:618(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2021/03/02 17:46:51.454960, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:641(pdb_set_fullname) pdb_set_full_name: setting full name Jeremy, was [2021/03/02 17:46:51.454975, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/substitute.c:345(automount_server) Home server: JEREMY-ACERB [2021/03/02 17:46:51.454992, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:734(pdb_set_homedir) pdb_set_homedir: setting home dir \\JEREMY-ACERB\jeremy, was [2021/03/02 17:46:51.455006, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:710(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2021/03/02 17:46:51.455021, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:664(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2021/03/02 17:46:51.455035, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/substitute.c:345(automount_server) Home server: JEREMY-ACERB [2021/03/02 17:46:51.455051, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:687(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\JEREMY-ACERB\jeremy\profile, was [2021/03/02 17:46:51.455065, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:777(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2021/03/02 17:46:51.455081, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455095, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455108, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455121, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.455133, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.455164, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/account_pol.c:364(account_policy_get) account_policy_get: name: password history, val: 0 [2021/03/02 17:46:51.455183, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455202, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:496(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-1914782597-1700840410-671320589-1000 [2021/03/02 17:46:51.455217, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_compat.c:73(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-1914782597-1700840410-671320589-1000 from rid 1000 [2021/03/02 17:46:51.455242, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455259, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455273, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455286, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.455298, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.455325, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/account_pol.c:364(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2021/03/02 17:46:51.455343, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455358, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:182(Get_Pwnam_alloc) Finding user jeremy [2021/03/02 17:46:51.455371, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:121(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is jeremy [2021/03/02 17:46:51.455420, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:159(Get_Pwnam_internals) Get_Pwnam_internals did find user [jeremy]! [2021/03/02 17:46:51.455473, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455488, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455501, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455514, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.455526, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.455564, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455580, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 1000 -> S-1-22-2-1000 fallback [2021/03/02 17:46:51.455601, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1631(get_primary_group_sid) Forcing Primary Group to 'Domain Users' for jeremy [2021/03/02 17:46:51.455618, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455632, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455646, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455658, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.455671, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.455697, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/account_pol.c:364(account_policy_get) account_policy_get: name: password history, val: 0 [2021/03/02 17:46:51.455715, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455744, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:572(pdb_set_username) pdb_set_username: setting username jeremy, was [2021/03/02 17:46:51.455759, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:595(pdb_set_domain) pdb_set_domain: setting domain JEREMY-ACERB, was [2021/03/02 17:46:51.455773, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:618(pdb_set_nt_username) pdb_set_nt_username: setting nt username , was [2021/03/02 17:46:51.455786, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:641(pdb_set_fullname) pdb_set_full_name: setting full name Jeremy, was [2021/03/02 17:46:51.455800, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/substitute.c:345(automount_server) Home server: JEREMY-ACERB [2021/03/02 17:46:51.455818, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:734(pdb_set_homedir) pdb_set_homedir: setting home dir \\JEREMY-ACERB\jeremy, was [2021/03/02 17:46:51.455832, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:710(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2021/03/02 17:46:51.455846, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:664(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2021/03/02 17:46:51.455860, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/substitute.c:345(automount_server) Home server: JEREMY-ACERB [2021/03/02 17:46:51.455876, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:687(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\JEREMY-ACERB\jeremy\profile, was [2021/03/02 17:46:51.455891, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:777(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2021/03/02 17:46:51.455906, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455920, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.455933, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.455945, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.455958, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.455984, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/account_pol.c:364(account_policy_get) account_policy_get: name: password history, val: 0 [2021/03/02 17:46:51.456002, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456018, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:496(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-1914782597-1700840410-671320589-1000 [2021/03/02 17:46:51.456034, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_compat.c:73(pdb_set_user_sid_from_rid) pdb_set_user_sid_from_rid: setting user sid S-1-5-21-1914782597-1700840410-671320589-1000 from rid 1000 [2021/03/02 17:46:51.456057, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_get_set.c:559(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-1914782597-1700840410-671320589-513 [2021/03/02 17:46:51.456086, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.456105, 4, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/auth/ntlm_check.c:406(ntlm_password_check) ntlm_password_check: Checking NTLMv2 password with domain [WORKGROUP] [2021/03/02 17:46:51.456145, 4, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/check_samsec.c:183(sam_account_ok) sam_account_ok: Checking SMB password for user jeremy [2021/03/02 17:46:51.456161, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/check_samsec.c:164(logon_hours_ok) logon_hours_ok: user jeremy allowed to logon at this time (Wed Mar 3 01:46:51 2021 ) [2021/03/02 17:46:51.456180, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456193, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.456207, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456220, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.456233, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.456262, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/account_pol.c:364(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2021/03/02 17:46:51.456281, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.456298, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456311, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.456325, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456338, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.456352, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.456376, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:182(Get_Pwnam_alloc) Finding user jeremy [2021/03/02 17:46:51.456389, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:121(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is jeremy [2021/03/02 17:46:51.456406, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:159(Get_Pwnam_internals) Get_Pwnam_internals did find user [jeremy]! [2021/03/02 17:46:51.456423, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.456438, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456451, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.456464, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.456483, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.456511, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/account_pol.c:364(account_policy_get) account_policy_get: name: minimum password age, val: 0 [2021/03/02 17:46:51.456531, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456547, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.456560, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456573, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.456586, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.456599, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.456625, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/account_pol.c:364(account_policy_get) account_policy_get: name: maximum password age, val: -1 [2021/03/02 17:46:51.456645, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.456662, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:182(Get_Pwnam_alloc) Finding user jeremy [2021/03/02 17:46:51.456677, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:121(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is jeremy [2021/03/02 17:46:51.456693, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:159(Get_Pwnam_internals) Get_Pwnam_internals did find user [jeremy]! [2021/03/02 17:46:51.456719, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/system_smbd.c:176(sys_getgrouplist) sys_getgrouplist: user [jeremy] [2021/03/02 17:46:51.467822, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.467843, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.467856, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.467874, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.467888, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.467929, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.467947, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 1000 -> S-1-22-2-1000 fallback [2021/03/02 17:46:51.467981, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.467996, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468013, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468027, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.468040, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.468074, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468091, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 4 -> S-1-22-2-4 fallback [2021/03/02 17:46:51.468117, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468131, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468145, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468158, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.468171, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.468203, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468220, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 24 -> S-1-22-2-24 fallback [2021/03/02 17:46:51.468243, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468257, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468270, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468283, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.468295, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.468327, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468343, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 27 -> S-1-22-2-27 fallback [2021/03/02 17:46:51.468371, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468386, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468399, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468411, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.468423, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.468458, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468473, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 30 -> S-1-22-2-30 fallback [2021/03/02 17:46:51.468497, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468510, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468524, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468537, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.468550, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.468583, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468599, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 46 -> S-1-22-2-46 fallback [2021/03/02 17:46:51.468622, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468636, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.468648, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.468661, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.469229, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.469268, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.469285, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 118 -> S-1-22-2-118 fallback [2021/03/02 17:46:51.469317, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.469333, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.469345, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.469358, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.469371, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.469405, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.469422, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 129 -> S-1-22-2-129 fallback [2021/03/02 17:46:51.469454, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.469470, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 2 [2021/03/02 17:46:51.469484, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3 [2021/03/02 17:46:51.469498, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.469511, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.469544, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.469560, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 134 -> S-1-22-2-134 fallback [2021/03/02 17:46:51.469585, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/server_info_sam.c:121(make_server_info_sam) make_server_info_sam: made server info for user jeremy -> jeremy [2021/03/02 17:46:51.469607, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.469628, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:268(auth_check_ntlm_password) auth_check_ntlm_password: sam_ignoredomain authentication for user [jeremy] succeeded [2021/03/02 17:46:51.469647, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.469661, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.469674, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.469687, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.469700, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.469727, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.469742, 5, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:295(auth_check_ntlm_password) check_ntlm_password: PAM Account for user [jeremy] succeeded [2021/03/02 17:46:51.469776, 3, pid=592878, effective(0, 0), real(0, 0), class=auth_audit] ../../auth/auth_log.c:635(log_authentication_event_human_readable) Auth: [SMB2,(null)] user [WORKGROUP]\[jeremy] at [Tue, 02 Mar 2021 17:46:51.469762 PST] with [NTLMv2] status [NT_STATUS_OK] workstation [JEREMY-ACERB] remote host [ipv4:127.0.0.1:46096] became [JEREMY-ACERB]\[jeremy] [S-1-5-21-1914782597-1700840410-671320589-1000]. local host [ipv4:127.0.0.1:445] {"timestamp": "2021-03-02T17:46:51.469858-0800", "type": "Authentication", "Authentication": {"version": {"major": 1, "minor": 2}, "eventId": 4624, "logonId": "0", "logonType": 3, "status": "NT_STATUS_OK", "localAddress": "ipv4:127.0.0.1:445", "remoteAddress": "ipv4:127.0.0.1:46096", "serviceDescription": "SMB2", "authDescription": null, "clientDomain": "WORKGROUP", "clientAccount": "jeremy", "workstation": "JEREMY-ACERB", "becameAccount": "jeremy", "becameDomain": "JEREMY-ACERB", "becameSid": "S-1-5-21-1914782597-1700840410-671320589-1000", "mappedAccount": "jeremy", "mappedDomain": "WORKGROUP", "netlogonComputer": null, "netlogonTrustAccount": null, "netlogonNegotiateFlags": "0x00000000", "netlogonSecureChannelType": 0, "netlogonTrustAccountSid": null, "passwordType": "NTLMv2", "duration": 23503}} [2021/03/02 17:46:51.469909, 2, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:324(auth_check_ntlm_password) check_ntlm_password: authentication for user [jeremy] -> [jeremy] -> [jeremy] succeeded [2021/03/02 17:46:51.469927, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:3950(lp_load_ex) lp_load_ex: refreshing parameters [2021/03/02 17:46:51.469947, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:1376(free_param_opts) Freeing parametrics: [2021/03/02 17:46:51.470017, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:553(init_globals) Initialising global parameters [2021/03/02 17:46:51.470097, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:811(debug_dump_status) INFO: Current debug levels: all: 10 tdb: 10 printdrivers: 10 lanman: 10 smb: 10 rpc_parse: 10 rpc_srv: 10 rpc_cli: 10 passdb: 10 sam: 10 auth: 10 winbind: 10 vfs: 10 idmap: 10 quota: 10 acls: 10 locking: 10 msdfs: 10 dmapi: 10 registry: 10 scavenger: 10 dns: 10 ldb: 10 tevent: 10 auth_audit: 10 auth_json_audit: 10 kerberos: 10 drs_repl: 10 smb2: 10 smb2_credits: 10 dsdb_audit: 10 dsdb_json_audit: 10 dsdb_password_audit: 10 dsdb_password_json_audit: 10 dsdb_transaction_audit: 10 dsdb_transaction_json_audit: 10 dsdb_group_audit: 10 dsdb_group_json_audit: 10 [2021/03/02 17:46:51.470273, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2852(lp_do_section) Processing section "[global]" doing parameter max log size = 0 doing parameter workgroup = WORKGROUP doing parameter realm = WORKGROUP.COM doing parameter passdb backend = tdbsam doing parameter netbios name = jeremy-acerb doing parameter security = user doing parameter log file = /usr/local/samba/var/log.%m.%d doing parameter panic action = "/bin/sleep 90000" doing parameter create mode = 07777 doing parameter directory mask = 07777 doing parameter kernel oplocks = no doing parameter ea support = yes doing parameter store dos attributes = yes doing parameter map readonly = no doing parameter map archive = no doing parameter map system = no doing parameter server signing = auto doing parameter domain master = no doing parameter local master = no doing parameter preferred master = no doing parameter domain logons = no [2021/03/02 17:46:51.470585, 1, pid=592878, effective(0, 0), real(0, 0)] ../../lib/param/loadparm.c:1871(lpcfg_do_global_parameter) lpcfg_do_global_parameter: WARNING: The "domain logons" option is deprecated doing parameter map to guest = Bad Password doing parameter guest account = nobody doing parameter ntlm auth = yes doing parameter load printers = no doing parameter printing = bsd doing parameter printcap name = /dev/null doing parameter disable spoolss = yes doing parameter usershare max shares = 100 [2021/03/02 17:46:51.470726, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2869(lp_do_section) Processing section "[charset]" doing parameter path = /tmp/charset doing parameter guest ok = yes doing parameter read only = no doing parameter force user = jeremy [2021/03/02 17:46:51.470827, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2869(lp_do_section) Processing section "[tmp1]" [2021/03/02 17:46:51.470846, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:1376(free_param_opts) Freeing parametrics: doing parameter wide links = yes doing parameter vfs objects = aio_pthread doing parameter aio_pthread:aio open = true doing parameter strict sync = yes doing parameter sync always = yes doing parameter path = /./tmp///// doing parameter read only = no doing parameter guest ok = yes [2021/03/02 17:46:51.471039, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2869(lp_do_section) Processing section "[tmp-snap]" [2021/03/02 17:46:51.471056, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:1376(free_param_opts) Freeing parametrics: doing parameter path = /tmp doing parameter read only = no doing parameter vfs objects = shadow_copy2 doing parameter shadow:snapdir = .snapshots doing parameter shadow:snapdirseverywhere = yes [2021/03/02 17:46:51.471185, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2869(lp_do_section) Processing section "[tmp]" doing parameter path = /tmp doing parameter read only = no [2021/03/02 17:46:51.471240, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2869(lp_do_section) Processing section "[aio_delay_inject]" [2021/03/02 17:46:51.471256, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:1376(free_param_opts) Freeing parametrics: doing parameter copy = tmp [2021/03/02 17:46:51.471282, 3, pid=592878, effective(0, 0), real(0, 0)] ../../lib/param/loadparm.c:1242(handle_copy) Copying service from service tmp doing parameter vfs objects = delay_inject doing parameter delay_inject:pread_send = 2000 doing parameter delay_inject:pwrite_send = 2000 [2021/03/02 17:46:51.471387, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2869(lp_do_section) Processing section "[uring1]" doing parameter path = /home/jeremy/tmp/uring doing parameter read only = no [2021/03/02 17:46:51.471443, 2, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2869(lp_do_section) Processing section "[ptest]" doing parameter path = /tmp/posix_test doing parameter read only = no doing parameter admin users = jeremy [2021/03/02 17:46:51.471516, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:3992(lp_load_ex) pm_process() returned Yes [2021/03/02 17:46:51.471546, 7, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:4327(lp_servicenumber) lp_servicenumber: couldn't find homes [2021/03/02 17:46:51.471571, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:1653(lp_add_ipc) adding IPC service [2021/03/02 17:46:51.471603, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/auth_ntlmssp.c:260(auth3_check_password_send) auth3_check_password_send: Got NT session key of length 16 [2021/03/02 17:46:51.471620, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/auth_ntlmssp.c:269(auth3_check_password_send) auth3_check_password_send: Got LM session key of length 8 [2021/03/02 17:46:51.471636, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send) gensec_update_send: ntlmssp[0x564b5f559f80]: subreq: 0x564b5f546060 [2021/03/02 17:46:51.471654, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:455(gensec_update_send) gensec_update_send: spnego[0x564b5f56bd40]: subreq: 0x564b5f578030 [2021/03/02 17:46:51.471676, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.471714, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:321(create_local_nt_token_from_info3) Create local NT token for jeremy [2021/03/02 17:46:51.471763, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:58(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: value=[1000:U] [2021/03/02 17:46:51.471780, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:76(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: id=[1000], endptr=[:U] [2021/03/02 17:46:51.471800, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1441(sid_to_uid) sid S-1-5-21-1914782597-1700840410-671320589-1000 -> uid 1000 [2021/03/02 17:46:51.471846, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/system_smbd.c:176(sys_getgrouplist) sys_getgrouplist: user [jeremy] [2021/03/02 17:46:51.472213, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472230, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472244, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472258, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.472271, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.472307, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472324, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 1000 -> S-1-22-2-1000 fallback [2021/03/02 17:46:51.472347, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472362, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472375, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472388, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.472402, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.472435, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472450, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 4 -> S-1-22-2-4 fallback [2021/03/02 17:46:51.472474, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472489, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472502, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472516, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.472529, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.472559, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472575, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 24 -> S-1-22-2-24 fallback [2021/03/02 17:46:51.472598, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472618, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472633, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472646, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.472660, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.472693, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472708, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 27 -> S-1-22-2-27 fallback [2021/03/02 17:46:51.472731, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472747, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472760, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472774, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.472787, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.472821, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472837, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 30 -> S-1-22-2-30 fallback [2021/03/02 17:46:51.472859, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472875, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472889, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.472902, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.472915, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.472949, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.472964, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 46 -> S-1-22-2-46 fallback [2021/03/02 17:46:51.472987, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473002, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473015, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473037, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.473050, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.473085, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473101, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 118 -> S-1-22-2-118 fallback [2021/03/02 17:46:51.473124, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473139, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473152, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473165, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.473178, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.473209, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473225, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 129 -> S-1-22-2-129 fallback [2021/03/02 17:46:51.473247, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473262, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473276, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473289, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.473302, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.473335, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473351, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 134 -> S-1-22-2-134 fallback [2021/03/02 17:46:51.473372, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473387, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473400, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473413, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.473425, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.473466, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:688(finalize_local_nt_token) Failed to fetch domain sid for WORKGROUP [2021/03/02 17:46:51.473491, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473514, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473530, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473542, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473556, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.473569, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.473598, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1574(pdb_default_sid_to_id) Could not find map for sid S-1-5-32-544 [2021/03/02 17:46:51.473619, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/pdb_util.c:162(create_builtin_administrators) create_builtin_administrators: Failed to create Administrators [2021/03/02 17:46:51.473639, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473661, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473676, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473689, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473703, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.473716, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.473745, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1574(pdb_default_sid_to_id) Could not find map for sid S-1-5-32-545 [2021/03/02 17:46:51.473765, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/pdb_util.c:132(create_builtin_users) create_builtin_users: Failed to create Users [2021/03/02 17:46:51.473784, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473805, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473819, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473833, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473846, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.473860, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.473892, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1574(pdb_default_sid_to_id) Could not find map for sid S-1-5-32-546 [2021/03/02 17:46:51.473917, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/pdb_util.c:205(create_builtin_guests) create_builtin_guests: Failed to create Guests [2021/03/02 17:46:51.473936, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473954, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473969, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.473982, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.473996, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.474010, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.474236, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.474261, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-1914782597-1700840410-671320589-1000] [2021/03/02 17:46:51.474281, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-1914782597-1700840410-671320589-513] [2021/03/02 17:46:51.474299, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-1000] [2021/03/02 17:46:51.474317, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-4] [2021/03/02 17:46:51.474335, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-24] [2021/03/02 17:46:51.474353, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-27] [2021/03/02 17:46:51.474371, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-30] [2021/03/02 17:46:51.474389, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-46] [2021/03/02 17:46:51.474408, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-118] [2021/03/02 17:46:51.474426, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-129] [2021/03/02 17:46:51.474445, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-134] [2021/03/02 17:46:51.474464, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:179(get_privileges_for_sids) get_privileges_for_sids: sid = S-1-1-0 Privilege set: 0x0 [2021/03/02 17:46:51.474485, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-2] [2021/03/02 17:46:51.474503, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-11] [2021/03/02 17:46:51.474530, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:58(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: value=[1000:U] [2021/03/02 17:46:51.474545, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:76(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: id=[1000], endptr=[:U] [2021/03/02 17:46:51.474588, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1318(sids_to_unixids) wbcSidsToUnixIds returned WBC_ERR_WINBIND_NOT_AVAILABLE [2021/03/02 17:46:51.474605, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.474619, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.474633, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.474647, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.474660, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.474685, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1761(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2021/03/02 17:46:51.474701, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.474715, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.474728, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.474743, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.474756, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.474785, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_tdb.c:660(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2021/03/02 17:46:51.474831, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.474849, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1838(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2021/03/02 17:46:51.474864, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1545(pdb_default_sid_to_id) SID S-1-5-21-1914782597-1700840410-671320589-513 belongs to our domain, but there is no corresponding object in the database. [2021/03/02 17:46:51.474888, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.474903, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-21-1914782597-1700840410-671320589-513 [2021/03/02 17:46:51.474919, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.474938, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.474953, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.474966, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.474978, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475002, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1761(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2021/03/02 17:46:51.475018, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.475031, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475044, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.475058, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.475071, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475099, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_tdb.c:660(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2021/03/02 17:46:51.475125, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475139, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1838(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2021/03/02 17:46:51.475153, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1545(pdb_default_sid_to_id) SID S-1-5-21-1914782597-1700840410-671320589-513 belongs to our domain, but there is no corresponding object in the database. [2021/03/02 17:46:51.475174, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475189, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-21-1914782597-1700840410-671320589-513 [2021/03/02 17:46:51.475204, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475218, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475231, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475244, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.475256, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475284, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475302, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-1-0 [2021/03/02 17:46:51.475317, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475332, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475344, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475357, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.475369, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475399, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475414, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-1-0 [2021/03/02 17:46:51.475428, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475443, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475456, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475470, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.475483, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475512, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475529, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-2 [2021/03/02 17:46:51.475542, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475557, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475568, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475581, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.475595, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475622, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475637, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-2 [2021/03/02 17:46:51.475650, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475665, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475682, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475695, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.475707, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475736, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475752, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-11 [2021/03/02 17:46:51.475765, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475778, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475791, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.475804, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.475816, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.475845, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.475860, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-11 [2021/03/02 17:46:51.475875, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-5-21-1914782597-1700840410-671320589-513 to gid, ignoring it [2021/03/02 17:46:51.475891, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-1-0 to gid, ignoring it [2021/03/02 17:46:51.475905, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-5-2 to gid, ignoring it [2021/03/02 17:46:51.475918, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-5-11 to gid, ignoring it [2021/03/02 17:46:51.475937, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../libcli/security/security_token.c:51(security_token_debug) Security token SIDs (15): SID[ 0]: S-1-5-21-1914782597-1700840410-671320589-1000 SID[ 1]: S-1-5-21-1914782597-1700840410-671320589-513 SID[ 2]: S-1-22-2-1000 SID[ 3]: S-1-22-2-4 SID[ 4]: S-1-22-2-24 SID[ 5]: S-1-22-2-27 SID[ 6]: S-1-22-2-30 SID[ 7]: S-1-22-2-46 SID[ 8]: S-1-22-2-118 SID[ 9]: S-1-22-2-129 SID[ 10]: S-1-22-2-134 SID[ 11]: S-1-1-0 SID[ 12]: S-1-5-2 SID[ 13]: S-1-5-11 SID[ 14]: S-1-22-1-1000 Privileges (0x 0): Rights (0x 0): [2021/03/02 17:46:51.476013, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 1000 Primary group is 1000 and contains 9 supplementary groups Group[ 0]: 1000 Group[ 1]: 4 Group[ 2]: 24 Group[ 3]: 27 Group[ 4]: 30 Group[ 5]: 46 Group[ 6]: 118 Group[ 7]: 129 Group[ 8]: 134 [2021/03/02 17:46:51.476073, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_server.c:965(ntlmssp_server_postauth) ntlmssp_server_auth: Using unmodified nt session key. [2021/03/02 17:46:51.476098, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:623(ntlmssp_sign_reset) NTLMSSP Sign/Seal - Initialising with flags: [2021/03/02 17:46:51.476112, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0x62088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2021/03/02 17:46:51.476157, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:52(dump_arc4_state) dump_arc4_state: NTLMSSP send seal arc4 state: [2021/03/02 17:46:51.476178, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:52(dump_arc4_state) dump_arc4_state: NTLMSSP recv seal arc4 state: [2021/03/02 17:46:51.476202, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:547(gensec_update_done) gensec_update_done: ntlmssp[0x564b5f559f80]: NT_STATUS_OK tevent_req[0x564b5f546060/../../auth/ntlmssp/ntlmssp.c:180]: state[2] error[0 (0x0)] state[struct gensec_ntlmssp_update_state (0x564b5f546210)] timer[(nil)] finish[../../auth/ntlmssp/ntlmssp.c:244] [2021/03/02 17:46:51.476223, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:320(ntlmssp_check_packet) ntlmssp_check_packet: NTLMSSP signature OK ! [2021/03/02 17:46:51.476245, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:623(ntlmssp_sign_reset) NTLMSSP Sign/Seal - Initialising with flags: [2021/03/02 17:46:51.476259, 3, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0x62088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY NTLMSSP_NEGOTIATE_VERSION NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2021/03/02 17:46:51.476303, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:52(dump_arc4_state) dump_arc4_state: NTLMSSP send seal arc4 state: [2021/03/02 17:46:51.476323, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/ntlmssp/ntlmssp_sign.c:52(dump_arc4_state) dump_arc4_state: NTLMSSP recv seal arc4 state: [2021/03/02 17:46:51.476343, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../auth/gensec/gensec.c:547(gensec_update_done) gensec_update_done: spnego[0x564b5f56bd40]: NT_STATUS_OK tevent_req[0x564b5f578030/../../auth/gensec/spnego.c:1631]: state[2] error[0 (0x0)] state[struct gensec_spnego_update_state (0x564b5f5781e0)] timer[(nil)] finish[../../auth/gensec/spnego.c:2116] [2021/03/02 17:46:51.476360, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.476375, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.476388, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.476400, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.476413, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.476446, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.476467, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:321(create_local_nt_token_from_info3) Create local NT token for jeremy [2021/03/02 17:46:51.476494, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:58(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: value=[1000:U] [2021/03/02 17:46:51.476508, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:76(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: id=[1000], endptr=[:U] [2021/03/02 17:46:51.476521, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1441(sid_to_uid) sid S-1-5-21-1914782597-1700840410-671320589-1000 -> uid 1000 [2021/03/02 17:46:51.476565, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/system_smbd.c:176(sys_getgrouplist) sys_getgrouplist: user [jeremy] [2021/03/02 17:46:51.482937, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.482957, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.482972, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.482986, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483000, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483039, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483057, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 1000 -> S-1-22-2-1000 fallback [2021/03/02 17:46:51.483083, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483098, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483112, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483126, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483139, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483177, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483194, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 4 -> S-1-22-2-4 fallback [2021/03/02 17:46:51.483219, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483235, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483249, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483268, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483281, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483316, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483331, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 24 -> S-1-22-2-24 fallback [2021/03/02 17:46:51.483355, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483370, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483384, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483398, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483411, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483445, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483462, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 27 -> S-1-22-2-27 fallback [2021/03/02 17:46:51.483486, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483501, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483515, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483529, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483543, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483579, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483595, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 30 -> S-1-22-2-30 fallback [2021/03/02 17:46:51.483617, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483632, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483646, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483659, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483673, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483710, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483726, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 46 -> S-1-22-2-46 fallback [2021/03/02 17:46:51.483751, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483767, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483781, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483794, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483808, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483841, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483858, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 118 -> S-1-22-2-118 fallback [2021/03/02 17:46:51.483882, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483898, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483912, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.483925, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.483939, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.483973, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.483990, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 129 -> S-1-22-2-129 fallback [2021/03/02 17:46:51.484014, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484029, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484042, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484056, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.484069, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.484106, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484123, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1245(xid_to_sid) xid_to_sid: GID 134 -> S-1-22-2-134 fallback [2021/03/02 17:46:51.484144, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484164, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484178, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484192, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.484205, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.484233, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:688(finalize_local_nt_token) Failed to fetch domain sid for WORKGROUP [2021/03/02 17:46:51.484252, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484274, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484290, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484304, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484318, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.484331, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.484362, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1574(pdb_default_sid_to_id) Could not find map for sid S-1-5-32-544 [2021/03/02 17:46:51.484383, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/pdb_util.c:162(create_builtin_administrators) create_builtin_administrators: Failed to create Administrators [2021/03/02 17:46:51.484403, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484426, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484441, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484455, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484469, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.484482, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.484512, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1574(pdb_default_sid_to_id) Could not find map for sid S-1-5-32-545 [2021/03/02 17:46:51.484534, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/pdb_util.c:132(create_builtin_users) create_builtin_users: Failed to create Users [2021/03/02 17:46:51.484555, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484576, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484596, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484609, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484623, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.484636, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.484664, 10, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1574(pdb_default_sid_to_id) Could not find map for sid S-1-5-32-546 [2021/03/02 17:46:51.484683, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/pdb_util.c:205(create_builtin_guests) create_builtin_guests: Failed to create Guests [2021/03/02 17:46:51.484703, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484722, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484737, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484751, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.484764, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.484778, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.484918, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.484941, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-1914782597-1700840410-671320589-1000] [2021/03/02 17:46:51.484961, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-1914782597-1700840410-671320589-513] [2021/03/02 17:46:51.484979, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-1000] [2021/03/02 17:46:51.484997, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-4] [2021/03/02 17:46:51.485015, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-24] [2021/03/02 17:46:51.485034, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-27] [2021/03/02 17:46:51.485052, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-30] [2021/03/02 17:46:51.485071, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-46] [2021/03/02 17:46:51.485090, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-118] [2021/03/02 17:46:51.485112, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-129] [2021/03/02 17:46:51.485129, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-22-2-134] [2021/03/02 17:46:51.485148, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:179(get_privileges_for_sids) get_privileges_for_sids: sid = S-1-1-0 Privilege set: 0x0 [2021/03/02 17:46:51.485169, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-2] [2021/03/02 17:46:51.485188, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/privileges.c:99(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-11] [2021/03/02 17:46:51.485215, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:58(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: value=[1000:U] [2021/03/02 17:46:51.485231, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/idmap_cache.c:76(idmap_cache_find_sid2unixid) Parsing value for key [IDMAP/SID2XID/S-1-5-21-1914782597-1700840410-671320589-1000]: id=[1000], endptr=[:U] [2021/03/02 17:46:51.485263, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1318(sids_to_unixids) wbcSidsToUnixIds returned WBC_ERR_WINBIND_NOT_AVAILABLE [2021/03/02 17:46:51.485278, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485293, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.485306, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485318, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.485331, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.485356, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1761(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2021/03/02 17:46:51.485372, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.485387, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485400, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.485413, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.485426, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.485453, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_tdb.c:660(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2021/03/02 17:46:51.485482, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485498, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1838(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2021/03/02 17:46:51.485516, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1545(pdb_default_sid_to_id) SID S-1-5-21-1914782597-1700840410-671320589-513 belongs to our domain, but there is no corresponding object in the database. [2021/03/02 17:46:51.485539, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.485554, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-21-1914782597-1700840410-671320589-513 [2021/03/02 17:46:51.485569, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485583, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.485596, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485609, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.485622, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.485644, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1761(lookup_global_sam_rid) lookup_global_sam_rid: looking up RID 513. [2021/03/02 17:46:51.485660, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.485674, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485688, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2021/03/02 17:46:51.485701, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.485713, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.485740, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_tdb.c:660(tdbsam_getsampwrid) pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201. [2021/03/02 17:46:51.485766, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485781, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1838(lookup_global_sam_rid) Can't find a unix id for an unmapped group [2021/03/02 17:46:51.485795, 5, pid=592878, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_interface.c:1545(pdb_default_sid_to_id) SID S-1-5-21-1914782597-1700840410-671320589-513 belongs to our domain, but there is no corresponding object in the database. [2021/03/02 17:46:51.485815, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.485830, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-21-1914782597-1700840410-671320589-513 [2021/03/02 17:46:51.485846, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485864, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.485877, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485890, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.485902, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.485931, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.485946, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-1-0 [2021/03/02 17:46:51.485961, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.485975, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.485989, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486002, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.486014, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.486041, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486056, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-1-0 [2021/03/02 17:46:51.486070, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486083, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486096, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486110, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.486122, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.486150, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486165, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-2 [2021/03/02 17:46:51.486180, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486193, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486206, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486219, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.486236, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.486264, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486279, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-2 [2021/03/02 17:46:51.486294, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486308, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486321, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486334, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.486346, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.486375, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486390, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-11 [2021/03/02 17:46:51.486405, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486419, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:561(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486433, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2021/03/02 17:46:51.486446, 5, pid=592878, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug) Security token: (NULL) [2021/03/02 17:46:51.486459, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2021/03/02 17:46:51.486485, 4, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2021/03/02 17:46:51.486500, 10, pid=592878, effective(0, 0), real(0, 0)] ../../source3/passdb/lookup_sid.c:1144(legacy_sid_to_unixid) LEGACY: mapping failed for sid S-1-5-11 [2021/03/02 17:46:51.486515, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-5-21-1914782597-1700840410-671320589-513 to gid, ignoring it [2021/03/02 17:46:51.486532, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-1-0 to gid, ignoring it [2021/03/02 17:46:51.486546, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-5-2 to gid, ignoring it [2021/03/02 17:46:51.486560, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:636(create_local_token) Could not convert SID S-1-5-11 to gid, ignoring it [2021/03/02 17:46:51.486581, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../libcli/security/security_token.c:51(security_token_debug) Security token SIDs (15): SID[ 0]: S-1-5-21-1914782597-1700840410-671320589-1000 SID[ 1]: S-1-5-21-1914782597-1700840410-671320589-513 SID[ 2]: S-1-22-2-1000 SID[ 3]: S-1-22-2-4 SID[ 4]: S-1-22-2-24 SID[ 5]: S-1-22-2-27 SID[ 6]: S-1-22-2-30 SID[ 7]: S-1-22-2-46 SID[ 8]: S-1-22-2-118 SID[ 9]: S-1-22-2-129 SID[ 10]: S-1-22-2-134 SID[ 11]: S-1-1-0 SID[ 12]: S-1-5-2 SID[ 13]: S-1-5-11 SID[ 14]: S-1-22-1-1000 Privileges (0x 0): Rights (0x 0): [2021/03/02 17:46:51.486662, 10, pid=592878, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/token_util.c:873(debug_unix_user_token) UNIX token of user 1000 Primary group is 1000 and contains 9 supplementary groups Group[ 0]: 1000 Group[ 1]: 4 Group[ 2]: 24 Group[ 3]: 27 Group[ 4]: 30 Group[ 5]: 46 Group[ 6]: 118 Group[ 7]: 129 Group[ 8]: 134 [2021/03/02 17:46:51.486729, 4, pid=592878, effective(0, 0), real(0, 0), class=auth_audit] ../../auth/auth_log.c:740(log_successful_authz_event_human_readable) Successful AuthZ: [SMB2,NTLMSSP] user [JEREMY-ACERB]\[jeremy] [S-1-5-21-1914782597-1700840410-671320589-1000] at [Tue, 02 Mar 2021 17:46:51.486719 PST] Remote host [ipv4:127.0.0.1:46096] local host [ipv4:127.0.0.1:445] {"timestamp": "2021-03-02T17:46:51.486767-0800", "type": "Authorization", "Authorization": {"version": {"major": 1, "minor": 1}, "localAddress": "ipv4:127.0.0.1:445", "remoteAddress": "ipv4:127.0.0.1:46096", "serviceDescription": "SMB2", "authType": "NTLMSSP", "domain": "JEREMY-ACERB", "account": "jeremy", "sid": "S-1-5-21-1914782597-1700840410-671320589-1000", "sessionId": "eb3a4ee7-6d63-4013-9af5-3d0b16cff1b3", "logonServer": "JEREMY-ACERB", "transportProtection": "SMB", "accountFlags": "0x00000010"}} [2021/03/02 17:46:51.486860, 7, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:4327(lp_servicenumber) lp_servicenumber: couldn't find jeremy [2021/03/02 17:46:51.486877, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:182(Get_Pwnam_alloc) Finding user jeremy [2021/03/02 17:46:51.486891, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:121(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is jeremy [2021/03/02 17:46:51.486907, 5, pid=592878, effective(0, 0), real(0, 0)] ../../source3/lib/username.c:159(Get_Pwnam_internals) Get_Pwnam_internals did find user [jeremy]! [2021/03/02 17:46:51.486925, 3, pid=592878, effective(0, 0), real(0, 0)] ../../source3/smbd/password.c:84(register_homes_share) Adding homes service for user 'jeremy' using home directory: '/home/jeremy' [2021/03/02 17:46:51.486951, 7, pid=592878, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:4327(lp_servicenumber) lp_servicenumber: couldn't find homes [2021/03/02 17:46:51.486976, 5, pid=592878, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:811(debug_dump_status) INFO: Current debug levels: all: 10 tdb: 10 printdrivers: 10 lanman: 10 smb: 10 rpc_parse: 10 rpc_srv: 10 rpc_cli: 10 passdb: 10 sam: 10 auth: 10 winbind: 10 vfs: 10 idmap: 10 quota: 10 acls: 10 locking: 10 msdfs: 10 dmapi: 10 registry: 10 scavenger: 10 dns: 10 ldb: 10 tevent: 10 auth_audit: 10 auth_json_audit: 10 kerberos: 10 drs_repl: 10 smb2: 10 smb2_credits: 10 dsdb_audit: 10 dsdb_json_audit: 10 dsdb_password_audit: 10 dsdb_password_json_audit: 10 dsdb_transaction_audit: 10 dsdb_transaction_json_audit: 10 dsdb_group_audit: 10 dsdb_group_json_audit: 10