Skip to content

Instantly share code, notes, and snippets.

@NelsonMinar
Last active December 13, 2022 17:38
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save NelsonMinar/38489bdc425003f593d0449dd966f401 to your computer and use it in GitHub Desktop.
Save NelsonMinar/38489bdc425003f593d0449dd966f401 to your computer and use it in GitHub Desktop.
sonos / samba logs
Samba logs when failing to connect with my Sonos v1. This used to work in Ubuntu 20.04, started failing in Ubuntu 22.04.
Context: https://lists.samba.org/archive/samba/2022-December/243258.html
Server is Ubuntu 22.10 with Ubuntu's package of samba 2:4.16.4+dfsg-2ubuntu1 installed.
Below are three snippets from log.192.168.0.203, the log for my Sonos client machine.
These logins all work with smbclient on the same machine, and from a Windows 10 client.
They used to work with the Sonos too.
Login with username "nelson" and a real password.
[2022/12/13 17:19:47.579119, 2] ../../source3/smbd/sesssetup.c:529(setup_new_vc_session)
setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2022/12/13 17:19:47.580462, 2] ../../source3/auth/auth.c:324(auth_check_ntlm_password)
check_ntlm_password: authentication for user [nelson] -> [nelson] -> [nelson] succeeded
[2022/12/13 17:19:47.580519, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "lanman auth" option is deprecated
[2022/12/13 17:19:47.580529, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client use spnego" option is deprecated
[2022/12/13 17:19:47.580533, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client ntlmv2 auth" option is deprecated
[2022/12/13 17:19:47.580570, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[homes]"
[2022/12/13 17:19:47.580591, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[musicshare]"
[2022/12/13 17:19:47.580602, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[videoshare]"
[2022/12/13 17:19:47.582908, 2] ../../source3/smbd/service.c:854(make_connection_snum)
192.168.0.203 (ipv4:192.168.0.203:33740) connect to service musicshare initially as user nelson (uid=30193, gid=30193) (pid 2019752)
[2022/12/13 17:19:47.588504, 2] ../../source3/smbd/service.c:1125(close_cnum)
192.168.0.203 (ipv4:192.168.0.203:33740) closed connection to service musicshare
Login with username "guest" and empty password
[2022/12/13 17:20:22.303433, 2] ../../source3/smbd/sesssetup.c:529(setup_new_vc_session)
setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2022/12/13 17:20:22.303700, 2] ../../source3/auth/auth.c:345(auth_check_ntlm_password)
check_ntlm_password: Authentication for user [guest] -> [guest] FAILED with error NT_STATUS_NO_SUCH_USER, authoritative=1
[2022/12/13 17:20:22.303809, 2] ../../auth/auth_log.c:647(log_authentication_event_human_readable)
Auth: [SMB,(null)] user []\[guest] at [Tue, 13 Dec 2022 17:20:22.303769 UTC] with [NTLMv1] status [NT_STATUS_NO_SUCH_USER] workstation [192.168.0.203] remote host [ipv4:192.168.0.203:33742] mapped to []\[guest]. local host [ipv4:192.168.0.2:445]
{"timestamp": "2022-12-13T17:20:22.303964+0000", "type": "Authentication", "Authentication": {"version": {"major": 1, "minor": 2}, "eventId": 4625, "logonId": "0", "logonType": 3, "status": "NT_STATUS_NO_SUCH_USER", "localAddress": "ipv4:192.168.0.2:445", "remoteAddress": "ipv4:192.168.0.203:33742", "serviceDescription": "SMB", "authDescription": null, "clientDomain": "", "clientAccount": "guest", "workstation": "192.168.0.203", "becameAccount": null, "becameDomain": null, "becameSid": null, "mappedAccount": "guest", "mappedDomain": "", "netlogonComputer": null, "netlogonTrustAccount": null, "netlogonNegotiateFlags": "0x00000000", "netlogonSecureChannelType": 0, "netlogonTrustAccountSid": null, "passwordType": "NTLMv1", "duration": 3087}}
[2022/12/13 17:20:22.304427, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "lanman auth" option is deprecated
[2022/12/13 17:20:22.304505, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client use spnego" option is deprecated
[2022/12/13 17:20:22.304531, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client ntlmv2 auth" option is deprecated
[2022/12/13 17:20:22.304871, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[homes]"
[2022/12/13 17:20:22.305023, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[musicshare]"
[2022/12/13 17:20:22.305111, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[videoshare]"
[2022/12/13 17:20:22.308202, 2] ../../source3/smbd/service.c:854(make_connection_snum)
192.168.0.203 (ipv4:192.168.0.203:33742) connect to service musicshare initially as user nobody (uid=65534, gid=65534) (pid 2019800)
[2022/12/13 17:20:22.315308, 2] ../../source3/smbd/service.c:1125(close_cnum)
192.168.0.203 (ipv4:192.168.0.203:33742) closed connection to service musicshare
Login with empty username and empty password
[2022/12/13 17:20:33.320703, 2] ../../source3/smbd/sesssetup.c:529(setup_new_vc_session)
setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2022/12/13 17:20:33.320969, 2] ../../source3/auth/auth.c:345(auth_check_ntlm_password)
check_ntlm_password: Authentication for user [guest] -> [guest] FAILED with error NT_STATUS_NO_SUCH_USER, authoritative=1
[2022/12/13 17:20:33.321077, 2] ../../auth/auth_log.c:647(log_authentication_event_human_readable)
Auth: [SMB,(null)] user []\[guest] at [Tue, 13 Dec 2022 17:20:33.321038 UTC] with [NTLMv1] status [NT_STATUS_NO_SUCH_USER] workstation [192.168.0.203] remote host [ipv4:192.168.0.203:33744] mapped to []\[guest]. local host [ipv4:192.168.0.2:445]
{"timestamp": "2022-12-13T17:20:33.321232+0000", "type": "Authentication", "Authentication": {"version": {"major": 1, "minor": 2}, "eventId": 4625, "logonId": "0", "logonType": 3, "status": "NT_STATUS_NO_SUCH_USER", "localAddress": "ipv4:192.168.0.2:445", "remoteAddress": "ipv4:192.168.0.203:33744", "serviceDescription": "SMB", "authDescription": null, "clientDomain": "", "clientAccount": "guest", "workstation": "192.168.0.203", "becameAccount": null, "becameDomain": null, "becameSid": null, "mappedAccount": "guest", "mappedDomain": "", "netlogonComputer": null, "netlogonTrustAccount": null, "netlogonNegotiateFlags": "0x00000000", "netlogonSecureChannelType": 0, "netlogonTrustAccountSid": null, "passwordType": "NTLMv1", "duration": 3783}}
[2022/12/13 17:20:33.321754, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "lanman auth" option is deprecated
[2022/12/13 17:20:33.321833, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client use spnego" option is deprecated
[2022/12/13 17:20:33.321858, 1] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client ntlmv2 auth" option is deprecated
[2022/12/13 17:20:33.322158, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[homes]"
[2022/12/13 17:20:33.322304, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[musicshare]"
[2022/12/13 17:20:33.322390, 2] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[videoshare]"
[2022/12/13 17:20:33.325317, 2] ../../source3/smbd/service.c:854(make_connection_snum)
192.168.0.203 (ipv4:192.168.0.203:33744) connect to service musicshare initially as user nobody (uid=65534, gid=65534) (pid 2019805)
[2022/12/13 17:20:33.341675, 2] ../../source3/smbd/service.c:1125(close_cnum)
192.168.0.203 (ipv4:192.168.0.203:33744) closed connection to service musicshare
An attempt to connect with empty username and password
Log level 10
[2022/12/13 17:32:12.548567, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:896(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
[2022/12/13 17:32:12.550089, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2389(lp_file_list_changed)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Tue Dec 13 17:31:39 2022
[2022/12/13 17:32:12.550199, 3, pid=2021378, effective(0, 0), real(0, 0), class=locking] ../../source3/smbd/oplock.c:1427(init_oplocks)
init_oplocks: initializing messages.
[2022/12/13 17:32:12.550229, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 774 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550250, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 778 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550269, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 770 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550288, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 801 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550306, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 787 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550325, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 779 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550343, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 15 - private_data=(nil)
[2022/12/13 17:32:12.550362, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:727(messaging_register)
Overriding messaging pointer for type 15 - private_data=(nil)
[2022/12/13 17:32:12.550381, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:759(messaging_deregister)
Deregistering messaging pointer for type 16 - private_data=(nil)
[2022/12/13 17:32:12.550400, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 16 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550419, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:759(messaging_deregister)
Deregistering messaging pointer for type 33 - private_data=0x56481bbc0340
[2022/12/13 17:32:12.550438, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 33 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550456, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:759(messaging_deregister)
Deregistering messaging pointer for type 790 - private_data=(nil)
[2022/12/13 17:32:12.550475, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 790 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.550493, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:759(messaging_deregister)
Deregistering messaging pointer for type 791 - private_data=(nil)
[2022/12/13 17:32:12.550511, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:759(messaging_deregister)
Deregistering messaging pointer for type 1 - private_data=(nil)
[2022/12/13 17:32:12.550530, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 1 - private_data=(nil)
[2022/12/13 17:32:12.550554, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_event.c:100(event_add_idle)
event_add_idle: idle_evt(keepalive) 0x56481bbdcc90
[2022/12/13 17:32:12.550563, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_event.c:100(event_add_idle)
event_add_idle: idle_evt(deadtime) 0x56481bbbb750
[2022/12/13 17:32:12.550566, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_event.c:100(event_add_idle)
event_add_idle: idle_evt(housekeeping) 0x56481bbeaf80
[2022/12/13 17:32:12.550584, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 159
[2022/12/13 17:32:12.550590, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x9f
[2022/12/13 17:32:12.550592, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 0 of length 163 (0 toread)
[2022/12/13 17:32:12.550596, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=159
smb_com=0x72
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=32769
smb_tid=0
smb_pid=227
smb_uid=0
smb_mid=19723
smt_wct=0
smb_bcc=124
[2022/12/13 17:32:12.550609, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 02 50 41 44 44 49 4E 47 20 55 4E 55 53 45 44 00 .PADDING UNUSED.
[0010] 02 50 41 44 44 49 4E 47 20 55 4E 55 53 45 44 00 .PADDING UNUSED.
[0020] 02 50 41 44 44 49 4E 47 20 55 4E 55 53 45 44 00 .PADDING UNUSED.
[0030] 02 50 41 44 44 49 4E 47 20 55 4E 55 53 45 44 00 .PADDING UNUSED.
[0040] 02 50 41 44 44 49 4E 47 20 55 4E 55 53 45 44 00 .PADDING UNUSED.
[0050] 02 50 41 44 44 49 4E 47 20 55 4E 55 53 45 44 00 .PADDING UNUSED.
[0060] 02 50 41 44 44 49 4E 47 20 55 4E 55 53 45 44 00 .PADDING UNUSED.
[0070] 02 4E 54 20 4C 4D 20 30 2E 31 32 00 .NT LM 0 .12.
[2022/12/13 17:32:12.550638, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBnegprot (pid 2021378) conn 0x0
[2022/12/13 17:32:12.550644, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.550649, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.550655, 5, pid=2021378, 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
[2022/12/13 17:32:12.550665, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.550779, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [PADDING UNUSED]
[2022/12/13 17:32:12.550782, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [PADDING UNUSED]
[2022/12/13 17:32:12.550784, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [PADDING UNUSED]
[2022/12/13 17:32:12.550787, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [PADDING UNUSED]
[2022/12/13 17:32:12.550790, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [PADDING UNUSED]
[2022/12/13 17:32:12.550792, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [PADDING UNUSED]
[2022/12/13 17:32:12.550794, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [PADDING UNUSED]
[2022/12/13 17:32:12.550796, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:637(reply_negprot)
Requested protocol [NT LM 0.12]
[2022/12/13 17:32:12.550802, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:1079(set_remote_arch)
set_remote_arch: Client arch is 'CIFSFS'
[2022/12/13 17:32:12.550808, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:896(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
[2022/12/13 17:32:12.550859, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2389(lp_file_list_changed)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Tue Dec 13 17:31:39 2022
[2022/12/13 17:32:12.550869, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:896(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
[2022/12/13 17:32:12.550916, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2389(lp_file_list_changed)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Tue Dec 13 17:31:39 2022
[2022/12/13 17:32:12.550931, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:53(get_challenge)
get challenge: creating negprot_global_auth_context
[2022/12/13 17:32:12.550934, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:565(make_auth3_context_for_ntlm)
make_auth3_context_for_ntlm: Making default auth method list for server role = 'standalone server', encrypt passwords = yes
[2022/12/13 17:32:12.550939, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth)
Attempting to register auth backend anonymous
[2022/12/13 17:32:12.550942, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth)
Successfully added auth method 'anonymous'
[2022/12/13 17:32:12.550945, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth)
Attempting to register auth backend sam
[2022/12/13 17:32:12.550947, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth)
Successfully added auth method 'sam'
[2022/12/13 17:32:12.550949, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth)
Attempting to register auth backend sam_ignoredomain
[2022/12/13 17:32:12.550952, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth)
Successfully added auth method 'sam_ignoredomain'
[2022/12/13 17:32:12.550954, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth)
Attempting to register auth backend sam_netlogon3
[2022/12/13 17:32:12.550959, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth)
Successfully added auth method 'sam_netlogon3'
[2022/12/13 17:32:12.550961, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth)
Attempting to register auth backend winbind
[2022/12/13 17:32:12.550963, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth)
Successfully added auth method 'winbind'
[2022/12/13 17:32:12.550965, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:52(smb_register_auth)
Attempting to register auth backend unix
[2022/12/13 17:32:12.550968, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:64(smb_register_auth)
Successfully added auth method 'unix'
[2022/12/13 17:32:12.550970, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:426(load_auth_module)
load_auth_module: Attempting to find an auth method to match anonymous
[2022/12/13 17:32:12.550973, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:451(load_auth_module)
load_auth_module: auth method anonymous has a valid init
[2022/12/13 17:32:12.550975, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:426(load_auth_module)
load_auth_module: Attempting to find an auth method to match sam_ignoredomain
[2022/12/13 17:32:12.550978, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:451(load_auth_module)
load_auth_module: auth method sam_ignoredomain has a valid init
[2022/12/13 17:32:12.550980, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:61(get_challenge)
get challenge: getting challenge
[2022/12/13 17:32:12.550987, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:410(reply_nt1)
not using SPNEGO
[2022/12/13 17:32:12.550989, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:777(reply_negprot)
Selected protocol NT LM 0.12
[2022/12/13 17:32:12.550991, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/negprot.c:779(reply_negprot)
reply_negprot: negprot index=7
[2022/12/13 17:32:12.550995, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=95
smb_com=0x72
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=128
smb_flg2=49155
smb_tid=0
smb_pid=227
smb_uid=0
smb_mid=19723
smt_wct=17
smb_vwv[ 0]= 7 (0x7)
smb_vwv[ 1]=12803 (0x3203)
smb_vwv[ 2]= 256 (0x100)
smb_vwv[ 3]= 1024 (0x400)
smb_vwv[ 4]= 65 (0x41)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 256 (0x100)
smb_vwv[ 7]= 512 (0x200)
smb_vwv[ 8]= 7896 (0x1ED8)
smb_vwv[ 9]=64768 (0xFD00)
smb_vwv[10]=33011 (0x80F3)
smb_vwv[11]=45824 (0xB300)
smb_vwv[12]=55430 (0xD886)
smb_vwv[13]= 6357 (0x18D5)
smb_vwv[14]=55567 (0xD90F)
smb_vwv[15]= 1 (0x1)
smb_vwv[16]= 2048 (0x800)
smb_bcc=26
[2022/12/13 17:32:12.551025, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 05 0B D4 65 94 F9 B0 64 57 00 49 00 4E 00 4F 00 ...e...d W.I.N.O.
[0010] 53 00 00 00 54 00 54 00 00 00 S...T.T. ..
[2022/12/13 17:32:12.555605, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 234
[2022/12/13 17:32:12.555730, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0xea
[2022/12/13 17:32:12.555757, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 1 of length 238 (0 toread)
[2022/12/13 17:32:12.555788, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=234
smb_com=0x73
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=53249
smb_tid=0
smb_pid=227
smb_uid=0
smb_mid=19979
smt_wct=13
smb_vwv[ 0]= 255 (0xFF)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]=16640 (0x4100)
smb_vwv[ 3]= 50 (0x32)
smb_vwv[ 4]= 0 (0x0)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 0 (0x0)
smb_vwv[ 7]= 24 (0x18)
smb_vwv[ 8]= 24 (0x18)
smb_vwv[ 9]= 0 (0x0)
smb_vwv[10]= 0 (0x0)
smb_vwv[11]=53468 (0xD0DC)
smb_vwv[12]= 0 (0x0)
smb_bcc=173
[2022/12/13 17:32:12.556056, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 1A 1B 1D 4F CD 8A 73 88 EC 77 82 3F 7F 45 66 53 ...O..s. .w.?.EfS
[0010] 3D 5D B4 8F 6B 86 40 27 1A 1B 1D 4F CD 8A 73 88 =]..k.@' ...O..s.
[0020] EC 77 82 3F 7F 45 66 53 3D 5D B4 8F 6B 86 40 27 .w.?.EfS =]..k.@'
[0030] 00 67 00 75 00 65 00 73 00 74 00 00 00 00 00 4C .g.u.e.s .t.....L
[0040] 00 69 00 6E 00 75 00 78 00 20 00 76 00 65 00 72 .i.n.u.x . .v.e.r
[0050] 00 73 00 69 00 6F 00 6E 00 20 00 32 00 2E 00 34 .s.i.o.n . .2...4
[0060] 00 2E 00 32 00 32 00 2D 00 72 00 69 00 6E 00 63 ...2.2.- .r.i.n.c
[0070] 00 6F 00 6E 00 2D 00 00 00 43 00 49 00 46 00 53 .o.n.-.. .C.I.F.S
[0080] 00 20 00 56 00 46 00 53 00 20 00 43 00 6C 00 69 . .V.F.S . .C.l.i
[0090] 00 65 00 6E 00 74 00 20 00 66 00 6F 00 72 00 20 .e.n.t. .f.o.r.
[00A0] 00 4C 00 69 00 6E 00 75 00 78 00 00 00 .L.i.n.u .x...
[2022/12/13 17:32:12.556371, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBsesssetupX (pid 2021378) conn 0x0
[2022/12/13 17:32:12.556396, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.556419, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.556439, 5, pid=2021378, 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
[2022/12/13 17:32:12.556505, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.556557, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sesssetup.c:605(reply_sesssetup_and_X)
wct=13 flg2=0xd001
[2022/12/13 17:32:12.556630, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sesssetup.c:832(reply_sesssetup_and_X)
Domain=[] NativeOS=[Linux version 2.4.22-rincon-] NativeLanMan=[CIFS VFS Client for Linux] PrimaryDomain=[null]
[2022/12/13 17:32:12.556655, 2, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sesssetup.c:529(setup_new_vc_session)
setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2022/12/13 17:32:12.556676, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sesssetup.c:849(reply_sesssetup_and_X)
sesssetupX:name=[]\[guest]@[192.168.0.203]
[2022/12/13 17:32:12.556708, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:64(make_user_info)
attempting to make a user_info for guest (guest)
[2022/12/13 17:32:12.556729, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:72(make_user_info)
making strings for guest's user_info struct
[2022/12/13 17:32:12.556755, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:117(make_user_info)
making blobs for guest's user_info struct
[2022/12/13 17:32:12.556774, 10, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:163(make_user_info)
made a user_info for guest (guest)
[2022/12/13 17:32:12.556837, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:124(make_user_info_map)
Mapping user []\[guest] from workstation [192.168.0.203]
[2022/12/13 17:32:12.556874, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:64(make_user_info)
attempting to make a user_info for guest (guest)
[2022/12/13 17:32:12.556895, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:72(make_user_info)
making strings for guest's user_info struct
[2022/12/13 17:32:12.556915, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:117(make_user_info)
making blobs for guest's user_info struct
[2022/12/13 17:32:12.556934, 10, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/user_info.c:163(make_user_info)
made a user_info for guest (guest)
[2022/12/13 17:32:12.556962, 3, pid=2021378, 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 []\[guest]@[192.168.0.203] with the new password interface
[2022/12/13 17:32:12.556982, 3, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:204(auth_check_ntlm_password)
check_ntlm_password: mapped user is: []\[guest]@[192.168.0.203]
[2022/12/13 17:32:12.557001, 10, pid=2021378, 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
[2022/12/13 17:32:12.557020, 10, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:217(auth_check_ntlm_password)
challenge is:
[2022/12/13 17:32:12.557039, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 05 0B D4 65 94 F9 B0 64 ...e...d
[2022/12/13 17:32:12.557073, 10, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_builtin.c:42(check_anonymous_security)
Check auth for: [guest]
[2022/12/13 17:32:12.557092, 10, pid=2021378, 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
[2022/12/13 17:32:12.557113, 10, pid=2021378, 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: []\[guest]
[2022/12/13 17:32:12.557137, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:206(push_sec_ctx)
push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2022/12/13 17:32:12.557159, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:566(push_conn_ctx)
push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2022/12/13 17:32:12.557179, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2022/12/13 17:32:12.557198, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.557216, 5, pid=2021378, 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
[2022/12/13 17:32:12.557345, 5, pid=2021378, effective(0, 0), real(0, 0), class=passdb] ../../source3/passdb/pdb_tdb.c:602(tdbsam_getsampwnam)
pdb_getsampwnam (TDB): error fetching database.
Key: USER_guest
[2022/12/13 17:32:12.557386, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:443(pop_sec_ctx)
pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.557407, 3, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/check_samsec.c:398(check_sam_security)
check_sam_security: Couldn't find user 'guest' in passdb.
[2022/12/13 17:32:12.557429, 5, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:259(auth_check_ntlm_password)
auth_check_ntlm_password: sam_ignoredomain authentication for user [guest] FAILED with error NT_STATUS_NO_SUCH_USER, authoritative=1
[2022/12/13 17:32:12.557476, 2, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth.c:345(auth_check_ntlm_password)
check_ntlm_password: Authentication for user [guest] -> [guest] FAILED with error NT_STATUS_NO_SUCH_USER, authoritative=1
[2022/12/13 17:32:12.557550, 2, pid=2021378, effective(0, 0), real(0, 0), class=auth_audit] ../../auth/auth_log.c:647(log_authentication_event_human_readable)
Auth: [SMB,(null)] user []\[guest] at [Tue, 13 Dec 2022 17:32:12.557520 UTC] with [NTLMv1] status [NT_STATUS_NO_SUCH_USER] workstation [192.168.0.203] remote host [ipv4:192.168.0.203:33748] mapped to []\[guest]. local host [ipv4:192.168.0.2:445]
{"timestamp": "2022-12-13T17:32:12.557711+0000", "type": "Authentication", "Authentication": {"version": {"major": 1, "minor": 2}, "eventId": 4625, "logonId": "0", "logonType": 3, "status": "NT_STATUS_NO_SUCH_USER", "localAddress": "ipv4:192.168.0.2:445", "remoteAddress": "ipv4:192.168.0.203:33748", "serviceDescription": "SMB", "authDescription": null, "clientDomain": "", "clientAccount": "guest", "workstation": "192.168.0.203", "becameAccount": null, "becameDomain": null, "becameSid": null, "mappedAccount": "guest", "mappedDomain": "", "netlogonComputer": null, "netlogonTrustAccount": null, "netlogonNegotiateFlags": "0x00000000", "netlogonSecureChannelType": 0, "netlogonTrustAccountSid": null, "passwordType": "NTLMv1", "duration": 6787}}
[2022/12/13 17:32:12.557805, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/auth/auth_ntlmssp.c:213(auth3_check_password_send)
auth3_check_password_send: Checking NTLMSSP password for \guest failed: NT_STATUS_NO_SUCH_USER, authoritative=1
[2022/12/13 17:32:12.557832, 3, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/auth_util.c:2309(do_map_to_guest_server_info)
No such user guest [] - using guest account
[2022/12/13 17:32:12.557875, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:3971(lp_load_ex)
lp_load_ex: refreshing parameters
[2022/12/13 17:32:12.557898, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:1397(free_param_opts)
Freeing parametrics:
[2022/12/13 17:32:12.558040, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:557(init_globals)
Initialising global parameters
[2022/12/13 17:32:12.558246, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2873(lp_do_section)
Processing section "[global]"
doing parameter allow insecure wide links = yes
doing parameter client min protocol = NT1
doing parameter lanman auth = yes
[2022/12/13 17:32:12.558326, 1, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "lanman auth" option is deprecated
doing parameter ntlm auth = yes
doing parameter server min protocol = NT1
doing parameter ntlm auth = ntlmv1-permitted
doing parameter client use spnego = no
[2022/12/13 17:32:12.558435, 1, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client use spnego" option is deprecated
doing parameter client ntlmv2 auth = no
[2022/12/13 17:32:12.558473, 1, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/param/loadparm.c:1766(lpcfg_do_global_parameter)
lpcfg_do_global_parameter: WARNING: The "client ntlmv2 auth" option is deprecated
doing parameter workgroup = winos
doing parameter server string = %h server (Samba, Ubuntu)
doing parameter log level = 10
[2022/12/13 17:32:12.558585, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:896(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
doing parameter log file = /var/log/samba/log.%m
doing parameter max log size = 1000
doing parameter logging = file
doing parameter panic action = /usr/share/samba/panic-action %d
doing parameter server role = standalone server
doing parameter obey pam restrictions = yes
doing parameter unix password sync = yes
doing parameter passwd program = /usr/bin/passwd %u
doing parameter passwd chat = *Enter\snew\s*\spassword:* %n\n *Retype\snew\s*\spassword:* %n\n *password\supdated\ssuccessfully* .
doing parameter pam password change = yes
doing parameter map to guest = bad user
doing parameter usershare allow guests = yes
[2022/12/13 17:32:12.559246, 2, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[homes]"
doing parameter comment = Home Directories
doing parameter browseable = no
doing parameter read only = no
doing parameter create mask = 0755
doing parameter directory mask = 0755
doing parameter valid users = nelson
doing parameter follow symlinks = yes
doing parameter wide links = yes
[2022/12/13 17:32:12.559465, 2, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[musicshare]"
doing parameter path = /home/nelson/Music
doing parameter read only = yes
doing parameter printable = no
doing parameter guest ok = yes
doing parameter browseable = yes
doing parameter public = yes
[2022/12/13 17:32:12.559608, 2, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2890(lp_do_section)
Processing section "[videoshare]"
doing parameter path = /home/nelson/Videos
doing parameter read only = yes
doing parameter printable = no
doing parameter guest ok = yes
doing parameter browseable = yes
doing parameter public = yes
[2022/12/13 17:32:12.559756, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:4013(lp_load_ex)
pm_process() returned Yes
[2022/12/13 17:32:12.559787, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:1674(lp_add_ipc)
adding IPC service
[2022/12/13 17:32:12.559942, 4, pid=2021378, effective(0, 0), real(0, 0), class=auth_audit] ../../auth/auth_log.c:752(log_successful_authz_event_human_readable)
Successful AuthZ: [SMB,bare-NTLM] user [TT]\[nobody] [S-1-5-21-2489073828-2315570694-1441043443-501] at [Tue, 13 Dec 2022 17:32:12.559929 UTC] Remote host [ipv4:192.168.0.203:33748] local host [ipv4:192.168.0.2:445]
{"timestamp": "2022-12-13T17:32:12.559999+0000", "type": "Authorization", "Authorization": {"version": {"major": 1, "minor": 1}, "localAddress": "ipv4:192.168.0.2:445", "remoteAddress": "ipv4:192.168.0.203:33748", "serviceDescription": "SMB", "authType": "bare-NTLM", "domain": "TT", "account": "nobody", "sid": "S-1-5-21-2489073828-2315570694-1441043443-501", "sessionId": "5c8070e4-f1c9-43c5-ab7e-1eb8ef31a26f", "logonServer": null, "transportProtection": "SMB", "accountFlags": "0x00000000"}}
[2022/12/13 17:32:12.560076, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.560114, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_session_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.560143, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key 7FCA0E36
[2022/12/13 17:32:12.560187, 10, pid=2021378, 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 0x56481bbea670
[2022/12/13 17:32:12.560263, 10, pid=2021378, 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
[2022/12/13 17:32:12.560358, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:967(smbXsrv_session_global_store)
smbXsrv_session_global_store: key '7FCA0E36' stored
[2022/12/13 17:32:12.560381, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(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 : 0x7fca0e36 (2143948342)
session_wire_id : 0x00000000000021eb (8683)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
expiration_time : Thu Sep 14 02:48:05 AM 30828 UTC
auth_time : NTTIME(0)
auth_session_info_seqnum : 0x00000000 (0)
auth_session_info : NULL
connection_dialect : 0x0000 (0)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
signing_algo : 0x0000 (0)
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
encryption_cipher : 0x0000 (0)
signing_key : NULL
encryption_key : NULL
decryption_key : NULL
application_key : NULL
num_channels : 0x00000001 (1)
channels: ARRAY(1)
channels: struct smbXsrv_channel_global0
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
channel_id : 0x0000000000000001 (1)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
local_address : 'ipv4:192.168.0.2:445'
remote_address : 'ipv4:192.168.0.203:33748'
remote_name : '192.168.0.203'
signing_key : NULL
auth_session_info_seqnum : 0x00000000 (0)
connection : *
signing_algo : 0x0000 (0)
encryption_cipher : 0x0000 (0)
[2022/12/13 17:32:12.560970, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.560994, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key 7FCA0E36
[2022/12/13 17:32:12.561025, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1355(smbXsrv_session_create)
smbXsrv_session_create: global_id (0x7fca0e36) stored
[2022/12/13 17:32:12.561056, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(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 : 0x000021eb (8683)
global : *
global: struct smbXsrv_session_global0
db_rec : NULL
session_global_id : 0x7fca0e36 (2143948342)
session_wire_id : 0x00000000000021eb (8683)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
expiration_time : Thu Sep 14 02:48:05 AM 30828 UTC
auth_time : NTTIME(0)
auth_session_info_seqnum : 0x00000000 (0)
auth_session_info : NULL
connection_dialect : 0x0000 (0)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
signing_algo : 0x0000 (0)
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
encryption_cipher : 0x0000 (0)
signing_key : NULL
encryption_key : NULL
decryption_key : NULL
application_key : NULL
num_channels : 0x00000001 (1)
channels: ARRAY(1)
channels: struct smbXsrv_channel_global0
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
channel_id : 0x0000000000000001 (1)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
local_address : 'ipv4:192.168.0.2:445'
remote_address : 'ipv4:192.168.0.203:33748'
remote_name : '192.168.0.203'
signing_key : NULL
auth_session_info_seqnum : 0x00000000 (0)
connection : *
signing_algo : 0x0000 (0)
encryption_cipher : 0x0000 (0)
status : NT_STATUS_MORE_PROCESSING_REQUIRED
idle_time : Tue Dec 13 05:32:13 PM 2022 UTC
nonce_high_random : 0x0000000000000000 (0)
nonce_high_max : 0x0000000000000000 (0)
nonce_high : 0x0000000000000000 (0)
nonce_low : 0x0000000000000000 (0)
tcon_table : NULL
homes_snum : 0xffffffff (4294967295)
pending_auth : NULL
[2022/12/13 17:32:12.561864, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.561886, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_session_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.561916, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key 7FCA0E36
[2022/12/13 17:32:12.561937, 10, pid=2021378, 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 0x56481bbbb320
[2022/12/13 17:32:12.561985, 10, pid=2021378, 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
[2022/12/13 17:32:12.562028, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:967(smbXsrv_session_global_store)
smbXsrv_session_global_store: key '7FCA0E36' stored
[2022/12/13 17:32:12.562048, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(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 : 0x7fca0e36 (2143948342)
session_wire_id : 0x00000000000021eb (8683)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
expiration_time : Thu Sep 14 02:48:05 AM 30828 UTC
auth_time : Tue Dec 13 05:32:13 PM 2022 UTC
auth_session_info_seqnum : 0x00000001 (1)
auth_session_info : *
auth_session_info: struct auth_session_info
security_token : *
security_token: struct security_token
num_sids : 0x00000007 (7)
sids: ARRAY(7)
sids : S-1-5-21-2489073828-2315570694-1441043443-501
sids : S-1-5-21-2489073828-2315570694-1441043443-514
sids : S-1-22-2-65534
sids : S-1-1-0
sids : S-1-5-2
sids : S-1-5-32-546
sids : S-1-22-1-65534
privilege_mask : 0x0000000000000000 (0)
0: SEC_PRIV_MACHINE_ACCOUNT_BIT
0: SEC_PRIV_PRINT_OPERATOR_BIT
0: SEC_PRIV_ADD_USERS_BIT
0: SEC_PRIV_DISK_OPERATOR_BIT
0: SEC_PRIV_REMOTE_SHUTDOWN_BIT
0: SEC_PRIV_BACKUP_BIT
0: SEC_PRIV_RESTORE_BIT
0: SEC_PRIV_TAKE_OWNERSHIP_BIT
0: SEC_PRIV_INCREASE_QUOTA_BIT
0: SEC_PRIV_SECURITY_BIT
0: SEC_PRIV_LOAD_DRIVER_BIT
0: SEC_PRIV_SYSTEM_PROFILE_BIT
0: SEC_PRIV_SYSTEMTIME_BIT
0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT
0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT
0: SEC_PRIV_CREATE_PAGEFILE_BIT
0: SEC_PRIV_SHUTDOWN_BIT
0: SEC_PRIV_DEBUG_BIT
0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT
0: SEC_PRIV_CHANGE_NOTIFY_BIT
0: SEC_PRIV_UNDOCK_BIT
0: SEC_PRIV_ENABLE_DELEGATION_BIT
0: SEC_PRIV_MANAGE_VOLUME_BIT
0: SEC_PRIV_IMPERSONATE_BIT
0: SEC_PRIV_CREATE_GLOBAL_BIT
rights_mask : 0x00000000 (0)
0: LSA_POLICY_MODE_INTERACTIVE
0: LSA_POLICY_MODE_NETWORK
0: LSA_POLICY_MODE_BATCH
0: LSA_POLICY_MODE_SERVICE
0: LSA_POLICY_MODE_PROXY
0: LSA_POLICY_MODE_DENY_INTERACTIVE
0: LSA_POLICY_MODE_DENY_NETWORK
0: LSA_POLICY_MODE_DENY_BATCH
0: LSA_POLICY_MODE_DENY_SERVICE
0: LSA_POLICY_MODE_REMOTE_INTERACTIVE
0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE
0x00: LSA_POLICY_MODE_ALL (0)
0x00: LSA_POLICY_MODE_ALL_NT4 (0)
unix_token : *
unix_token: struct security_unix_token
uid : 0x000000000000fffe (65534)
gid : 0x000000000000fffe (65534)
ngroups : 0x00000001 (1)
groups: ARRAY(1)
groups : 0x000000000000fffe (65534)
info : *
info: struct auth_user_info
account_name : *
account_name : 'nobody'
user_principal_name : NULL
user_principal_constructed: 0x00 (0)
domain_name : *
domain_name : 'TT'
dns_domain_name : NULL
full_name : NULL
logon_script : NULL
profile_path : NULL
home_directory : NULL
home_drive : NULL
logon_server : NULL
last_logon : NTTIME(0)
last_logoff : NTTIME(0)
acct_expiry : NTTIME(0)
last_password_change : NTTIME(0)
allow_password_change : NTTIME(0)
force_password_change : NTTIME(0)
logon_count : 0x0000 (0)
bad_password_count : 0x0000 (0)
acct_flags : 0x00000000 (0)
authenticated : 0x00 (0)
unix_info : *
unix_info: struct auth_user_info_unix
unix_name : *
unix_name : 'nobody'
sanitized_username : *
sanitized_username : 'guest'
torture : NULL
credentials : NULL
unique_session_token : 5c8070e4-f1c9-43c5-ab7e-1eb8ef31a26f
ticket_type : TICKET_TYPE_UNKNOWN (0)
connection_dialect : 0x0000 (0)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
signing_algo : 0xfffe (65534)
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
encryption_cipher : 0x0000 (0)
signing_key : *
encryption_key : NULL
decryption_key : NULL
application_key : NULL
num_channels : 0x00000001 (1)
channels: ARRAY(1)
channels: struct smbXsrv_channel_global0
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
channel_id : 0x0000000000000001 (1)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
local_address : 'ipv4:192.168.0.2:445'
remote_address : 'ipv4:192.168.0.203:33748'
remote_name : '192.168.0.203'
signing_key : NULL
auth_session_info_seqnum : 0x00000001 (1)
connection : *
signing_algo : 0xfffe (65534)
encryption_cipher : 0x0000 (0)
[2022/12/13 17:32:12.563533, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.563552, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key 7FCA0E36
[2022/12/13 17:32:12.563577, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1459(smbXsrv_session_update)
smbXsrv_session_update: global_id (0x7fca0e36) stored
[2022/12/13 17:32:12.563593, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(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 : 0x000021eb (8683)
global : *
global: struct smbXsrv_session_global0
db_rec : NULL
session_global_id : 0x7fca0e36 (2143948342)
session_wire_id : 0x00000000000021eb (8683)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
expiration_time : Thu Sep 14 02:48:05 AM 30828 UTC
auth_time : Tue Dec 13 05:32:13 PM 2022 UTC
auth_session_info_seqnum : 0x00000001 (1)
auth_session_info : *
auth_session_info: struct auth_session_info
security_token : *
security_token: struct security_token
num_sids : 0x00000007 (7)
sids: ARRAY(7)
sids : S-1-5-21-2489073828-2315570694-1441043443-501
sids : S-1-5-21-2489073828-2315570694-1441043443-514
sids : S-1-22-2-65534
sids : S-1-1-0
sids : S-1-5-2
sids : S-1-5-32-546
sids : S-1-22-1-65534
privilege_mask : 0x0000000000000000 (0)
0: SEC_PRIV_MACHINE_ACCOUNT_BIT
0: SEC_PRIV_PRINT_OPERATOR_BIT
0: SEC_PRIV_ADD_USERS_BIT
0: SEC_PRIV_DISK_OPERATOR_BIT
0: SEC_PRIV_REMOTE_SHUTDOWN_BIT
0: SEC_PRIV_BACKUP_BIT
0: SEC_PRIV_RESTORE_BIT
0: SEC_PRIV_TAKE_OWNERSHIP_BIT
0: SEC_PRIV_INCREASE_QUOTA_BIT
0: SEC_PRIV_SECURITY_BIT
0: SEC_PRIV_LOAD_DRIVER_BIT
0: SEC_PRIV_SYSTEM_PROFILE_BIT
0: SEC_PRIV_SYSTEMTIME_BIT
0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT
0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT
0: SEC_PRIV_CREATE_PAGEFILE_BIT
0: SEC_PRIV_SHUTDOWN_BIT
0: SEC_PRIV_DEBUG_BIT
0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT
0: SEC_PRIV_CHANGE_NOTIFY_BIT
0: SEC_PRIV_UNDOCK_BIT
0: SEC_PRIV_ENABLE_DELEGATION_BIT
0: SEC_PRIV_MANAGE_VOLUME_BIT
0: SEC_PRIV_IMPERSONATE_BIT
0: SEC_PRIV_CREATE_GLOBAL_BIT
rights_mask : 0x00000000 (0)
0: LSA_POLICY_MODE_INTERACTIVE
0: LSA_POLICY_MODE_NETWORK
0: LSA_POLICY_MODE_BATCH
0: LSA_POLICY_MODE_SERVICE
0: LSA_POLICY_MODE_PROXY
0: LSA_POLICY_MODE_DENY_INTERACTIVE
0: LSA_POLICY_MODE_DENY_NETWORK
0: LSA_POLICY_MODE_DENY_BATCH
0: LSA_POLICY_MODE_DENY_SERVICE
0: LSA_POLICY_MODE_REMOTE_INTERACTIVE
0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE
0x00: LSA_POLICY_MODE_ALL (0)
0x00: LSA_POLICY_MODE_ALL_NT4 (0)
unix_token : *
unix_token: struct security_unix_token
uid : 0x000000000000fffe (65534)
gid : 0x000000000000fffe (65534)
ngroups : 0x00000001 (1)
groups: ARRAY(1)
groups : 0x000000000000fffe (65534)
info : *
info: struct auth_user_info
account_name : *
account_name : 'nobody'
user_principal_name : NULL
user_principal_constructed: 0x00 (0)
domain_name : *
domain_name : 'TT'
dns_domain_name : NULL
full_name : NULL
logon_script : NULL
profile_path : NULL
home_directory : NULL
home_drive : NULL
logon_server : NULL
last_logon : NTTIME(0)
last_logoff : NTTIME(0)
acct_expiry : NTTIME(0)
last_password_change : NTTIME(0)
allow_password_change : NTTIME(0)
force_password_change : NTTIME(0)
logon_count : 0x0000 (0)
bad_password_count : 0x0000 (0)
acct_flags : 0x00000000 (0)
authenticated : 0x00 (0)
unix_info : *
unix_info: struct auth_user_info_unix
unix_name : *
unix_name : 'nobody'
sanitized_username : *
sanitized_username : 'guest'
torture : NULL
credentials : NULL
unique_session_token : 5c8070e4-f1c9-43c5-ab7e-1eb8ef31a26f
ticket_type : TICKET_TYPE_UNKNOWN (0)
connection_dialect : 0x0000 (0)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
signing_algo : 0xfffe (65534)
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
encryption_cipher : 0x0000 (0)
signing_key : *
encryption_key : NULL
decryption_key : NULL
application_key : NULL
num_channels : 0x00000001 (1)
channels: ARRAY(1)
channels: struct smbXsrv_channel_global0
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
channel_id : 0x0000000000000001 (1)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
local_address : 'ipv4:192.168.0.2:445'
remote_address : 'ipv4:192.168.0.203:33748'
remote_name : '192.168.0.203'
signing_key : NULL
auth_session_info_seqnum : 0x00000001 (1)
connection : *
signing_algo : 0xfffe (65534)
encryption_cipher : 0x0000 (0)
status : NT_STATUS_OK
idle_time : Tue Dec 13 05:32:13 PM 2022 UTC
nonce_high_random : 0x0000000000000000 (0)
nonce_high_max : 0x0000000000000000 (0)
nonce_high : 0x0000000000000000 (0)
nonce_low : 0x0000000000000000 (0)
tcon_table : NULL
homes_snum : 0xffffffff (4294967295)
pending_auth : NULL
[2022/12/13 17:32:12.565042, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/debug.c:896(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
[2022/12/13 17:32:12.565422, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/param/loadparm.c:2389(lp_file_list_changed)
lp_file_list_changed()
file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Tue Dec 13 17:31:39 2022
[2022/12/13 17:32:12.565469, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=118
smb_com=0x73
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=128
smb_flg2=49155
smb_tid=0
smb_pid=227
smb_uid=8683
smb_mid=19979
smt_wct=3
smb_vwv[ 0]= 255 (0xFF)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]= 1 (0x1)
smb_bcc=77
[2022/12/13 17:32:12.565557, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 57 00 69 00 6E 00 64 00 6F 00 77 00 73 00 20 .W.i.n.d .o.w.s.
[0010] 00 36 00 2E 00 31 00 00 00 53 00 61 00 6D 00 62 .6...1.. .S.a.m.b
[0020] 00 61 00 20 00 34 00 2E 00 31 00 36 00 2E 00 34 .a. .4.. .1.6...4
[0030] 00 2D 00 55 00 62 00 75 00 6E 00 74 00 75 00 00 .-.U.b.u .n.t.u..
[0040] 00 57 00 49 00 4E 00 4F 00 53 00 00 00 .W.I.N.O .S...
[2022/12/13 17:32:12.569014, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 94
[2022/12/13 17:32:12.569145, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x5e
[2022/12/13 17:32:12.569170, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 2 of length 98 (0 toread)
[2022/12/13 17:32:12.569197, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=94
smb_com=0x75
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=53249
smb_tid=0
smb_pid=227
smb_uid=8683
smb_mid=20235
smt_wct=4
smb_vwv[ 0]= 255 (0xFF)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]= 8 (0x8)
smb_vwv[ 3]= 1 (0x1)
smb_bcc=51
[2022/12/13 17:32:12.569372, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 5C 00 5C 00 74 00 74 00 2E 00 6C 00 6F 00 63 .\.\.t.t ...l.o.c
[0010] 00 61 00 6C 00 5C 00 6D 00 75 00 73 00 69 00 63 .a.l.\.m .u.s.i.c
[0020] 00 73 00 68 00 61 00 72 00 65 00 00 00 3F 3F 3F .s.h.a.r .e...???
[0030] 3F 3F 00 ??.
[2022/12/13 17:32:12.569481, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBtconX (pid 2021378) conn 0x0
[2022/12/13 17:32:12.569507, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.569525, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.569543, 5, pid=2021378, 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
[2022/12/13 17:32:12.569594, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.569633, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.569653, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_session_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.569680, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key 7FCA0E36
[2022/12/13 17:32:12.569706, 10, pid=2021378, 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 0x56481bbbe930
[2022/12/13 17:32:12.569810, 10, pid=2021378, 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
[2022/12/13 17:32:12.569844, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:967(smbXsrv_session_global_store)
smbXsrv_session_global_store: key '7FCA0E36' stored
[2022/12/13 17:32:12.569864, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(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 : 0x7fca0e36 (2143948342)
session_wire_id : 0x00000000000021eb (8683)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
expiration_time : Thu Sep 14 02:48:05 AM 30828 UTC
auth_time : Tue Dec 13 05:32:13 PM 2022 UTC
auth_session_info_seqnum : 0x00000001 (1)
auth_session_info : *
auth_session_info: struct auth_session_info
security_token : *
security_token: struct security_token
num_sids : 0x00000007 (7)
sids: ARRAY(7)
sids : S-1-5-21-2489073828-2315570694-1441043443-501
sids : S-1-5-21-2489073828-2315570694-1441043443-514
sids : S-1-22-2-65534
sids : S-1-1-0
sids : S-1-5-2
sids : S-1-5-32-546
sids : S-1-22-1-65534
privilege_mask : 0x0000000000000000 (0)
0: SEC_PRIV_MACHINE_ACCOUNT_BIT
0: SEC_PRIV_PRINT_OPERATOR_BIT
0: SEC_PRIV_ADD_USERS_BIT
0: SEC_PRIV_DISK_OPERATOR_BIT
0: SEC_PRIV_REMOTE_SHUTDOWN_BIT
0: SEC_PRIV_BACKUP_BIT
0: SEC_PRIV_RESTORE_BIT
0: SEC_PRIV_TAKE_OWNERSHIP_BIT
0: SEC_PRIV_INCREASE_QUOTA_BIT
0: SEC_PRIV_SECURITY_BIT
0: SEC_PRIV_LOAD_DRIVER_BIT
0: SEC_PRIV_SYSTEM_PROFILE_BIT
0: SEC_PRIV_SYSTEMTIME_BIT
0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT
0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT
0: SEC_PRIV_CREATE_PAGEFILE_BIT
0: SEC_PRIV_SHUTDOWN_BIT
0: SEC_PRIV_DEBUG_BIT
0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT
0: SEC_PRIV_CHANGE_NOTIFY_BIT
0: SEC_PRIV_UNDOCK_BIT
0: SEC_PRIV_ENABLE_DELEGATION_BIT
0: SEC_PRIV_MANAGE_VOLUME_BIT
0: SEC_PRIV_IMPERSONATE_BIT
0: SEC_PRIV_CREATE_GLOBAL_BIT
rights_mask : 0x00000000 (0)
0: LSA_POLICY_MODE_INTERACTIVE
0: LSA_POLICY_MODE_NETWORK
0: LSA_POLICY_MODE_BATCH
0: LSA_POLICY_MODE_SERVICE
0: LSA_POLICY_MODE_PROXY
0: LSA_POLICY_MODE_DENY_INTERACTIVE
0: LSA_POLICY_MODE_DENY_NETWORK
0: LSA_POLICY_MODE_DENY_BATCH
0: LSA_POLICY_MODE_DENY_SERVICE
0: LSA_POLICY_MODE_REMOTE_INTERACTIVE
0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE
0x00: LSA_POLICY_MODE_ALL (0)
0x00: LSA_POLICY_MODE_ALL_NT4 (0)
unix_token : *
unix_token: struct security_unix_token
uid : 0x000000000000fffe (65534)
gid : 0x000000000000fffe (65534)
ngroups : 0x00000001 (1)
groups: ARRAY(1)
groups : 0x000000000000fffe (65534)
info : *
info: struct auth_user_info
account_name : *
account_name : 'nobody'
user_principal_name : NULL
user_principal_constructed: 0x00 (0)
domain_name : *
domain_name : 'TT'
dns_domain_name : NULL
full_name : NULL
logon_script : NULL
profile_path : NULL
home_directory : NULL
home_drive : NULL
logon_server : NULL
last_logon : NTTIME(0)
last_logoff : NTTIME(0)
acct_expiry : NTTIME(0)
last_password_change : NTTIME(0)
allow_password_change : NTTIME(0)
force_password_change : NTTIME(0)
logon_count : 0x0000 (0)
bad_password_count : 0x0000 (0)
acct_flags : 0x00000000 (0)
authenticated : 0x00 (0)
unix_info : *
unix_info: struct auth_user_info_unix
unix_name : *
unix_name : 'nobody'
sanitized_username : *
sanitized_username : 'guest'
torture : NULL
credentials : NULL
unique_session_token : 5c8070e4-f1c9-43c5-ab7e-1eb8ef31a26f
ticket_type : TICKET_TYPE_UNKNOWN (0)
connection_dialect : 0x0000 (0)
signing_flags : 0x04 (4)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
1: SMBXSRV_PROCESSED_UNSIGNED_PACKET
signing_algo : 0xfffe (65534)
encryption_flags : 0x08 (8)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
encryption_cipher : 0x0000 (0)
signing_key : *
encryption_key : NULL
decryption_key : NULL
application_key : NULL
num_channels : 0x00000001 (1)
channels: ARRAY(1)
channels: struct smbXsrv_channel_global0
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
channel_id : 0x0000000000000001 (1)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
local_address : 'ipv4:192.168.0.2:445'
remote_address : 'ipv4:192.168.0.203:33748'
remote_name : '192.168.0.203'
signing_key : NULL
auth_session_info_seqnum : 0x00000001 (1)
connection : *
signing_algo : 0xfffe (65534)
encryption_cipher : 0x8000 (32768)
[2022/12/13 17:32:12.571159, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.571176, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key 7FCA0E36
[2022/12/13 17:32:12.571197, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1459(smbXsrv_session_update)
smbXsrv_session_update: global_id (0x7fca0e36) stored
[2022/12/13 17:32:12.571209, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(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 : 0x000021eb (8683)
global : *
global: struct smbXsrv_session_global0
db_rec : NULL
session_global_id : 0x7fca0e36 (2143948342)
session_wire_id : 0x00000000000021eb (8683)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
expiration_time : Thu Sep 14 02:48:05 AM 30828 UTC
auth_time : Tue Dec 13 05:32:13 PM 2022 UTC
auth_session_info_seqnum : 0x00000001 (1)
auth_session_info : *
auth_session_info: struct auth_session_info
security_token : *
security_token: struct security_token
num_sids : 0x00000007 (7)
sids: ARRAY(7)
sids : S-1-5-21-2489073828-2315570694-1441043443-501
sids : S-1-5-21-2489073828-2315570694-1441043443-514
sids : S-1-22-2-65534
sids : S-1-1-0
sids : S-1-5-2
sids : S-1-5-32-546
sids : S-1-22-1-65534
privilege_mask : 0x0000000000000000 (0)
0: SEC_PRIV_MACHINE_ACCOUNT_BIT
0: SEC_PRIV_PRINT_OPERATOR_BIT
0: SEC_PRIV_ADD_USERS_BIT
0: SEC_PRIV_DISK_OPERATOR_BIT
0: SEC_PRIV_REMOTE_SHUTDOWN_BIT
0: SEC_PRIV_BACKUP_BIT
0: SEC_PRIV_RESTORE_BIT
0: SEC_PRIV_TAKE_OWNERSHIP_BIT
0: SEC_PRIV_INCREASE_QUOTA_BIT
0: SEC_PRIV_SECURITY_BIT
0: SEC_PRIV_LOAD_DRIVER_BIT
0: SEC_PRIV_SYSTEM_PROFILE_BIT
0: SEC_PRIV_SYSTEMTIME_BIT
0: SEC_PRIV_PROFILE_SINGLE_PROCESS_BIT
0: SEC_PRIV_INCREASE_BASE_PRIORITY_BIT
0: SEC_PRIV_CREATE_PAGEFILE_BIT
0: SEC_PRIV_SHUTDOWN_BIT
0: SEC_PRIV_DEBUG_BIT
0: SEC_PRIV_SYSTEM_ENVIRONMENT_BIT
0: SEC_PRIV_CHANGE_NOTIFY_BIT
0: SEC_PRIV_UNDOCK_BIT
0: SEC_PRIV_ENABLE_DELEGATION_BIT
0: SEC_PRIV_MANAGE_VOLUME_BIT
0: SEC_PRIV_IMPERSONATE_BIT
0: SEC_PRIV_CREATE_GLOBAL_BIT
rights_mask : 0x00000000 (0)
0: LSA_POLICY_MODE_INTERACTIVE
0: LSA_POLICY_MODE_NETWORK
0: LSA_POLICY_MODE_BATCH
0: LSA_POLICY_MODE_SERVICE
0: LSA_POLICY_MODE_PROXY
0: LSA_POLICY_MODE_DENY_INTERACTIVE
0: LSA_POLICY_MODE_DENY_NETWORK
0: LSA_POLICY_MODE_DENY_BATCH
0: LSA_POLICY_MODE_DENY_SERVICE
0: LSA_POLICY_MODE_REMOTE_INTERACTIVE
0: LSA_POLICY_MODE_DENY_REMOTE_INTERACTIVE
0x00: LSA_POLICY_MODE_ALL (0)
0x00: LSA_POLICY_MODE_ALL_NT4 (0)
unix_token : *
unix_token: struct security_unix_token
uid : 0x000000000000fffe (65534)
gid : 0x000000000000fffe (65534)
ngroups : 0x00000001 (1)
groups: ARRAY(1)
groups : 0x000000000000fffe (65534)
info : *
info: struct auth_user_info
account_name : *
account_name : 'nobody'
user_principal_name : NULL
user_principal_constructed: 0x00 (0)
domain_name : *
domain_name : 'TT'
dns_domain_name : NULL
full_name : NULL
logon_script : NULL
profile_path : NULL
home_directory : NULL
home_drive : NULL
logon_server : NULL
last_logon : NTTIME(0)
last_logoff : NTTIME(0)
acct_expiry : NTTIME(0)
last_password_change : NTTIME(0)
allow_password_change : NTTIME(0)
force_password_change : NTTIME(0)
logon_count : 0x0000 (0)
bad_password_count : 0x0000 (0)
acct_flags : 0x00000000 (0)
authenticated : 0x00 (0)
unix_info : *
unix_info: struct auth_user_info_unix
unix_name : *
unix_name : 'nobody'
sanitized_username : *
sanitized_username : 'guest'
torture : NULL
credentials : NULL
unique_session_token : 5c8070e4-f1c9-43c5-ab7e-1eb8ef31a26f
ticket_type : TICKET_TYPE_UNKNOWN (0)
connection_dialect : 0x0000 (0)
signing_flags : 0x04 (4)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
1: SMBXSRV_PROCESSED_UNSIGNED_PACKET
signing_algo : 0xfffe (65534)
encryption_flags : 0x08 (8)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
encryption_cipher : 0x0000 (0)
signing_key : *
encryption_key : NULL
decryption_key : NULL
application_key : NULL
num_channels : 0x00000001 (1)
channels: ARRAY(1)
channels: struct smbXsrv_channel_global0
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
channel_id : 0x0000000000000001 (1)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
local_address : 'ipv4:192.168.0.2:445'
remote_address : 'ipv4:192.168.0.203:33748'
remote_name : '192.168.0.203'
signing_key : NULL
auth_session_info_seqnum : 0x00000001 (1)
connection : *
signing_algo : 0xfffe (65534)
encryption_cipher : 0x8000 (32768)
status : NT_STATUS_OK
idle_time : Tue Dec 13 05:32:13 PM 2022 UTC
nonce_high_random : 0x0000000000000000 (0)
nonce_high_max : 0x0000000000000000 (0)
nonce_high : 0x0000000000000000 (0)
nonce_low : 0x0000000000000000 (0)
tcon_table : NULL
homes_snum : 0xffffffff (4294967295)
pending_auth : NULL
[2022/12/13 17:32:12.572451, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/reply.c:935(reply_tcon_and_X)
Client requested device type [?????] for share [musicshare]
[2022/12/13 17:32:12.572479, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:1104(make_connection)
making a connection to 'normal' service musicshare
[2022/12/13 17:32:12.572506, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.572519, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_tcon_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.572533, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key B849A046
[2022/12/13 17:32:12.572554, 10, pid=2021378, 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 0x56481bbea670
[2022/12/13 17:32:12.572622, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store)
smbXsrv_tcon_global_store: key 'B849A046' stored
[2022/12/13 17:32:12.572634, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(ndr_print_debug)
&global_blob: struct smbXsrv_tcon_globalB
version : SMBXSRV_VERSION_0 (0)
seqnum : 0x00000001 (1)
info : union smbXsrv_tcon_globalU(case 0)
info0 : *
info0: struct smbXsrv_tcon_global0
db_rec : *
tcon_global_id : 0xb849a046 (3091832902)
tcon_wire_id : 0x000072f6 (29430)
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
share_name : NULL
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
session_global_id : 0x00000000 (0)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
[2022/12/13 17:32:12.572817, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key B849A046
[2022/12/13 17:32:12.572829, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.572847, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:838(smbXsrv_tcon_create)
smbXsrv_tcon_create: global_id (0xb849a046) stored
[2022/12/13 17:32:12.572858, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(ndr_print_debug)
&tcon_blob: struct smbXsrv_tconB
version : SMBXSRV_VERSION_0 (0)
reserved : 0x00000000 (0)
info : union smbXsrv_tconU(case 0)
info0 : *
info0: struct smbXsrv_tcon
table : *
db_rec : NULL
local_id : 0x000072f6 (29430)
global : *
global: struct smbXsrv_tcon_global0
db_rec : NULL
tcon_global_id : 0xb849a046 (3091832902)
tcon_wire_id : 0x000072f6 (29430)
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
share_name : NULL
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
session_global_id : 0x00000000 (0)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
status : NT_STATUS_INTERNAL_ERROR
idle_time : Tue Dec 13 05:32:13 PM 2022 UTC
compat : NULL
[2022/12/13 17:32:12.573088, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/access.c:372(allow_access)
Allowed connection from 192.168.0.203 (192.168.0.203)
[2022/12/13 17:32:12.573143, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:71(set_conn_connectpath)
set_conn_connectpath: service musicshare, connectpath = /home/nelson/Music
[2022/12/13 17:32:12.573157, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:610(make_connection_snum)
make_connection_snum: Connect path is '/home/nelson/Music' for service [musicshare]
[2022/12/13 17:32:12.573170, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:238(user_ok_token)
user_ok_token: share musicshare is ok for unix user nobody
[2022/12/13 17:32:12.573182, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:286(is_share_read_only_for_token)
is_share_read_only_for_user: share musicshare is read-only for unix user nobody
[2022/12/13 17:32:12.573215, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/access_check.c:363(se_file_access_check)
se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff
[2022/12/13 17:32:12.573228, 3, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:115(vfs_init_default)
Initialising default vfs hooks
[2022/12/13 17:32:12.573239, 10, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry)
vfs_find_backend_entry called for /[Default VFS]/
[2022/12/13 17:32:12.573273, 5, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:105(smb_register_vfs)
Successfully added vfs backend '/[Default VFS]/'
[2022/12/13 17:32:12.573284, 10, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry)
vfs_find_backend_entry called for vfs_not_implemented
[2022/12/13 17:32:12.573295, 5, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:105(smb_register_vfs)
Successfully added vfs backend 'vfs_not_implemented'
[2022/12/13 17:32:12.573305, 10, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry)
vfs_find_backend_entry called for posixacl
[2022/12/13 17:32:12.573316, 5, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:105(smb_register_vfs)
Successfully added vfs backend 'posixacl'
[2022/12/13 17:32:12.573326, 3, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:141(vfs_init_custom)
Initialising custom vfs hooks from [/[Default VFS]/]
[2022/12/13 17:32:12.573337, 10, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:66(vfs_find_backend_entry)
vfs_find_backend_entry called for /[Default VFS]/
Successfully loaded vfs module [/[Default VFS]/] with the new modules system
[2022/12/13 17:32:12.573406, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/notify_msg.c:79(notify_init)
notify_init: notifyd=2021144
[2022/12/13 17:32:12.573420, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 784 - private_data=0x56481bbf2dd0
[2022/12/13 17:32:12.573433, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 793 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.573442, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:711(messaging_register)
Registering messaging pointer for type 799 - private_data=0x56481bbe5a10
[2022/12/13 17:32:12.573470, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:71(set_conn_connectpath)
set_conn_connectpath: service musicshare, connectpath = /mnt/bulk/Music
[2022/12/13 17:32:12.573484, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:238(user_ok_token)
user_ok_token: share musicshare is ok for unix user nobody
[2022/12/13 17:32:12.573501, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/share_access.c:286(is_share_read_only_for_token)
is_share_read_only_for_user: share musicshare is read-only for unix user nobody
[2022/12/13 17:32:12.573515, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/access_check.c:363(se_file_access_check)
se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff
[2022/12/13 17:32:12.573538, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.573549, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:51(security_token_debug)
Security token SIDs (7):
SID[ 0]: S-1-5-21-2489073828-2315570694-1441043443-501
SID[ 1]: S-1-5-21-2489073828-2315570694-1441043443-514
SID[ 2]: S-1-22-2-65534
SID[ 3]: S-1-1-0
SID[ 4]: S-1-5-2
SID[ 5]: S-1-5-32-546
SID[ 6]: S-1-22-1-65534
Privileges (0x 0):
Rights (0x 0):
[2022/12/13 17:32:12.573602, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token)
UNIX token of user 65534
Primary group is 65534 and contains 1 supplementary groups
Group[ 0]: 65534
[2022/12/13 17:32:12.573650, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:294(print_impersonation_info)
print_impersonation_info: Impersonated user: uid=(65534,65534), gid=(0,65534), cwd=[/]
[2022/12/13 17:32:12.573665, 4, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.573676, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.573684, 5, pid=2021378, effective(65534, 65534), real(65534, 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
[2022/12/13 17:32:12.573706, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.573721, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:71(set_conn_connectpath)
set_conn_connectpath: service musicshare, connectpath = /mnt/bulk/Music
[2022/12/13 17:32:12.573745, 10, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/modules/vfs_default.c:182(vfswrap_fs_capabilities)
vfswrap_fs_capabilities: timestamp resolution of sec available on share musicshare, directory /mnt/bulk/Music
[2022/12/13 17:32:12.573756, 2, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:854(make_connection_snum)
192.168.0.203 (ipv4:192.168.0.203:33748) connect to service musicshare initially as user nobody (uid=65534, gid=65534) (pid 2021378)
[2022/12/13 17:32:12.573774, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.573784, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_tcon_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.573796, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key B849A046
[2022/12/13 17:32:12.573807, 10, pid=2021378, 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 0x56481bbf1170
[2022/12/13 17:32:12.573825, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store)
smbXsrv_tcon_global_store: key 'B849A046' stored
[2022/12/13 17:32:12.573835, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(ndr_print_debug)
&global_blob: struct smbXsrv_tcon_globalB
version : SMBXSRV_VERSION_0 (0)
seqnum : 0x00000002 (2)
info : union smbXsrv_tcon_globalU(case 0)
info0 : *
info0: struct smbXsrv_tcon_global0
db_rec : *
tcon_global_id : 0xb849a046 (3091832902)
tcon_wire_id : 0x000072f6 (29430)
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
share_name : 'musicshare'
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
session_global_id : 0x7fca0e36 (2143948342)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
[2022/12/13 17:32:12.573990, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key B849A046
[2022/12/13 17:32:12.574000, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.574016, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_tcon.c:882(smbXsrv_tcon_update)
smbXsrv_tcon_update: global_id (0xb849a046) stored
[2022/12/13 17:32:12.574026, 1, pid=2021378, effective(0, 0), real(0, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(ndr_print_debug)
&tcon_blob: struct smbXsrv_tconB
version : SMBXSRV_VERSION_0 (0)
reserved : 0x00000000 (0)
info : union smbXsrv_tconU(case 0)
info0 : *
info0: struct smbXsrv_tcon
table : *
db_rec : NULL
local_id : 0x000072f6 (29430)
global : *
global: struct smbXsrv_tcon_global0
db_rec : NULL
tcon_global_id : 0xb849a046 (3091832902)
tcon_wire_id : 0x000072f6 (29430)
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
share_name : 'musicshare'
encryption_flags : 0x00 (0)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
0: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
session_global_id : 0x7fca0e36 (2143948342)
signing_flags : 0x00 (0)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
0: SMBXSRV_PROCESSED_UNSIGNED_PACKET
status : NT_STATUS_OK
idle_time : Tue Dec 13 05:32:13 PM 2022 UTC
compat : *
[2022/12/13 17:32:12.574212, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/reply.c:1111(reply_tcon_and_X)
tconX service=musicshare
[2022/12/13 17:32:12.574226, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=62
smb_com=0x75
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=128
smb_flg2=49155
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=20235
smt_wct=7
smb_vwv[ 0]= 255 (0xFF)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]= 1 (0x1)
smb_vwv[ 3]= 169 (0xA9)
smb_vwv[ 4]= 31 (0x1F)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 0 (0x0)
smb_bcc=13
[2022/12/13 17:32:12.574302, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 41 3A 00 4E 00 54 00 46 00 53 00 00 00 A:.N.T.F .S...
[2022/12/13 17:32:12.575582, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 68
[2022/12/13 17:32:12.575663, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x44
[2022/12/13 17:32:12.575677, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 3 of length 72 (0 toread)
[2022/12/13 17:32:12.575694, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=68
smb_com=0x32
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=49153
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=20491
smt_wct=15
smb_vwv[ 0]= 2 (0x2)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]= 2 (0x2)
smb_vwv[ 3]= 1000 (0x3E8)
smb_vwv[ 4]= 0 (0x0)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 0 (0x0)
smb_vwv[ 7]= 0 (0x0)
smb_vwv[ 8]= 0 (0x0)
smb_vwv[ 9]= 2 (0x2)
smb_vwv[10]= 66 (0x42)
smb_vwv[11]= 0 (0x0)
smb_vwv[12]= 0 (0x0)
smb_vwv[13]= 1 (0x1)
smb_vwv[14]= 3 (0x3)
smb_bcc=3
[2022/12/13 17:32:12.575810, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 04 01 ...
[2022/12/13 17:32:12.575845, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBtrans2 (pid 2021378) conn 0x56481bbcf890
[2022/12/13 17:32:12.575868, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (65534, 65534) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.575880, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:51(security_token_debug)
Security token SIDs (7):
SID[ 0]: S-1-5-21-2489073828-2315570694-1441043443-501
SID[ 1]: S-1-5-21-2489073828-2315570694-1441043443-514
SID[ 2]: S-1-22-2-65534
SID[ 3]: S-1-1-0
SID[ 4]: S-1-5-2
SID[ 5]: S-1-5-32-546
SID[ 6]: S-1-22-1-65534
Privileges (0x 0):
Rights (0x 0):
[2022/12/13 17:32:12.575937, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/auth/token_util.c:873(debug_unix_user_token)
UNIX token of user 65534
Primary group is 65534 and contains 1 supplementary groups
Group[ 0]: 65534
[2022/12/13 17:32:12.575980, 4, pid=2021378, effective(65534, 65534), real(65534, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir)
vfs_ChDir to /mnt/bulk/Music
[2022/12/13 17:32:12.576020, 5, pid=2021378, effective(65534, 65534), real(65534, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir)
vfs_ChDir: vfs_ChDir got /mnt/bulk/Music
[2022/12/13 17:32:12.576036, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:294(print_impersonation_info)
print_impersonation_info: Impersonated user: uid=(65534,65534), gid=(0,65534), cwd=[/mnt/bulk/Music]
[2022/12/13 17:32:12.576159, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.576171, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_tcon_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.576183, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key B849A046
[2022/12/13 17:32:12.576198, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/dbwrap/dbwrap_tdb.c:153(db_tdb_fetch_locked_internal)
db_tdb_fetch_locked_internal: Allocated locked data 0x56481bbbdac0
[2022/12/13 17:32:12.576228, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/smbXsrv_tcon.c:711(smbXsrv_tcon_global_store)
smbXsrv_tcon_global_store: key 'B849A046' stored
[2022/12/13 17:32:12.576238, 1, pid=2021378, effective(65534, 65534), real(65534, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(ndr_print_debug)
&global_blob: struct smbXsrv_tcon_globalB
version : SMBXSRV_VERSION_0 (0)
seqnum : 0x00000003 (3)
info : union smbXsrv_tcon_globalU(case 0)
info0 : *
info0: struct smbXsrv_tcon_global0
db_rec : *
tcon_global_id : 0xb849a046 (3091832902)
tcon_wire_id : 0x000072f6 (29430)
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
share_name : 'musicshare'
encryption_flags : 0x08 (8)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
session_global_id : 0x7fca0e36 (2143948342)
signing_flags : 0x04 (4)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
1: SMBXSRV_PROCESSED_UNSIGNED_PACKET
[2022/12/13 17:32:12.576392, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key B849A046
[2022/12/13 17:32:12.576402, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.576417, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/smbXsrv_tcon.c:882(smbXsrv_tcon_update)
smbXsrv_tcon_update: global_id (0xb849a046) stored
[2022/12/13 17:32:12.576426, 1, pid=2021378, effective(65534, 65534), real(65534, 0), class=rpc_parse] ../../librpc/ndr/ndr.c:435(ndr_print_debug)
&tcon_blob: struct smbXsrv_tconB
version : SMBXSRV_VERSION_0 (0)
reserved : 0x00000000 (0)
info : union smbXsrv_tconU(case 0)
info0 : *
info0: struct smbXsrv_tcon
table : *
db_rec : NULL
local_id : 0x000072f6 (29430)
global : *
global: struct smbXsrv_tcon_global0
db_rec : NULL
tcon_global_id : 0xb849a046 (3091832902)
tcon_wire_id : 0x000072f6 (29430)
server_id: struct server_id
pid : 0x00000000001ed802 (2021378)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x4b33dd3ef8da7f8d (5418918039189618573)
creation_time : Tue Dec 13 05:32:13 PM 2022 UTC
share_name : 'musicshare'
encryption_flags : 0x08 (8)
0: SMBXSRV_ENCRYPTION_REQUIRED
0: SMBXSRV_ENCRYPTION_DESIRED
0: SMBXSRV_PROCESSED_ENCRYPTED_PACKET
1: SMBXSRV_PROCESSED_UNENCRYPTED_PACKET
session_global_id : 0x7fca0e36 (2143948342)
signing_flags : 0x04 (4)
0: SMBXSRV_SIGNING_REQUIRED
0: SMBXSRV_PROCESSED_SIGNED_PACKET
1: SMBXSRV_PROCESSED_UNSIGNED_PACKET
status : NT_STATUS_OK
idle_time : Tue Dec 13 05:32:13 PM 2022 UTC
compat : *
[2022/12/13 17:32:12.576619, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:4228(call_trans2qfsinfo)
call_trans2qfsinfo: level = 260
[2022/12/13 17:32:12.576631, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:3514(smbd_do_qfsinfo)
smbd_do_qfsinfo: level = 260
[2022/12/13 17:32:12.576646, 9, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:1125(send_trans2_replies)
t2_rep: params_sent_thistime = 0, data_sent_thistime = 8, useable_space = 16580
[2022/12/13 17:32:12.576656, 9, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:1127(send_trans2_replies)
t2_rep: params_to_send = 0, data_to_send = 8, paramsize = 0, datasize = 8
[2022/12/13 17:32:12.576670, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=64
smb_com=0x32
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=128
smb_flg2=49155
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=20491
smt_wct=10
smb_vwv[ 0]= 0 (0x0)
smb_vwv[ 1]= 8 (0x8)
smb_vwv[ 2]= 0 (0x0)
smb_vwv[ 3]= 0 (0x0)
smb_vwv[ 4]= 56 (0x38)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 8 (0x8)
smb_vwv[ 7]= 56 (0x38)
smb_vwv[ 8]= 0 (0x0)
smb_vwv[ 9]= 0 (0x0)
smb_bcc=9
[2022/12/13 17:32:12.576756, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 07 00 00 00 22 00 00 00 .....".. .
[2022/12/13 17:32:12.576803, 4, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:4245(call_trans2qfsinfo)
SMBtrans2 info_level = 260
[2022/12/13 17:32:12.579076, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 68
[2022/12/13 17:32:12.579159, 6, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x44
[2022/12/13 17:32:12.579174, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 4 of length 72 (0 toread)
[2022/12/13 17:32:12.579190, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=68
smb_com=0x32
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=49153
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=20747
smt_wct=15
smb_vwv[ 0]= 2 (0x2)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]= 2 (0x2)
smb_vwv[ 3]= 1000 (0x3E8)
smb_vwv[ 4]= 0 (0x0)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 0 (0x0)
smb_vwv[ 7]= 0 (0x0)
smb_vwv[ 8]= 0 (0x0)
smb_vwv[ 9]= 2 (0x2)
smb_vwv[10]= 66 (0x42)
smb_vwv[11]= 0 (0x0)
smb_vwv[12]= 0 (0x0)
smb_vwv[13]= 1 (0x1)
smb_vwv[14]= 3 (0x3)
smb_bcc=3
[2022/12/13 17:32:12.579342, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 05 01 ...
[2022/12/13 17:32:12.579369, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBtrans2 (pid 2021378) conn 0x56481bbcf890
[2022/12/13 17:32:12.579384, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:327(change_to_user_impersonate)
change_to_user_impersonate: Skipping user change - already user
[2022/12/13 17:32:12.579414, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:294(print_impersonation_info)
print_impersonation_info: Impersonated user: uid=(65534,65534), gid=(0,65534), cwd=[/mnt/bulk/Music]
[2022/12/13 17:32:12.579431, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:4228(call_trans2qfsinfo)
call_trans2qfsinfo: level = 261
[2022/12/13 17:32:12.579449, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:3514(smbd_do_qfsinfo)
smbd_do_qfsinfo: level = 261
[2022/12/13 17:32:12.579471, 9, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:1125(send_trans2_replies)
t2_rep: params_sent_thistime = 0, data_sent_thistime = 20, useable_space = 16580
[2022/12/13 17:32:12.579481, 9, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:1127(send_trans2_replies)
t2_rep: params_to_send = 0, data_to_send = 20, paramsize = 0, datasize = 20
[2022/12/13 17:32:12.579496, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=76
smb_com=0x32
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=128
smb_flg2=49155
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=20747
smt_wct=10
smb_vwv[ 0]= 0 (0x0)
smb_vwv[ 1]= 20 (0x14)
smb_vwv[ 2]= 0 (0x0)
smb_vwv[ 3]= 0 (0x0)
smb_vwv[ 4]= 56 (0x38)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 20 (0x14)
smb_vwv[ 7]= 56 (0x38)
smb_vwv[ 8]= 0 (0x0)
smb_vwv[ 9]= 0 (0x0)
smb_bcc=21
[2022/12/13 17:32:12.579589, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 6F 00 01 00 FF 00 00 00 08 00 00 00 4E 00 54 .o...... .....N.T
[0010] 00 46 00 53 00 .F.S.
[2022/12/13 17:32:12.579657, 4, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:4245(call_trans2qfsinfo)
SMBtrans2 info_level = 261
[2022/12/13 17:32:12.580831, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 68
[2022/12/13 17:32:12.580914, 6, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x44
[2022/12/13 17:32:12.580928, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 5 of length 72 (0 toread)
[2022/12/13 17:32:12.580945, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=68
smb_com=0x32
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=49153
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=21003
smt_wct=15
smb_vwv[ 0]= 2 (0x2)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]= 2 (0x2)
smb_vwv[ 3]= 100 (0x64)
smb_vwv[ 4]= 0 (0x0)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 0 (0x0)
smb_vwv[ 7]= 0 (0x0)
smb_vwv[ 8]= 0 (0x0)
smb_vwv[ 9]= 2 (0x2)
smb_vwv[10]= 66 (0x42)
smb_vwv[11]= 0 (0x0)
smb_vwv[12]= 0 (0x0)
smb_vwv[13]= 1 (0x1)
smb_vwv[14]= 3 (0x3)
smb_bcc=3
[2022/12/13 17:32:12.581097, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 00 02 ...
[2022/12/13 17:32:12.581125, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBtrans2 (pid 2021378) conn 0x56481bbcf890
[2022/12/13 17:32:12.581140, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:327(change_to_user_impersonate)
change_to_user_impersonate: Skipping user change - already user
[2022/12/13 17:32:12.581169, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:294(print_impersonation_info)
print_impersonation_info: Impersonated user: uid=(65534,65534), gid=(0,65534), cwd=[/mnt/bulk/Music]
[2022/12/13 17:32:12.581187, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:4228(call_trans2qfsinfo)
call_trans2qfsinfo: level = 512
[2022/12/13 17:32:12.581204, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:3514(smbd_do_qfsinfo)
smbd_do_qfsinfo: level = 512
[2022/12/13 17:32:12.581220, 9, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:1125(send_trans2_replies)
t2_rep: params_sent_thistime = 0, data_sent_thistime = 12, useable_space = 16580
[2022/12/13 17:32:12.581230, 9, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:1127(send_trans2_replies)
t2_rep: params_to_send = 0, data_to_send = 12, paramsize = 0, datasize = 12
[2022/12/13 17:32:12.581272, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=68
smb_com=0x32
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=128
smb_flg2=49155
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=21003
smt_wct=10
smb_vwv[ 0]= 0 (0x0)
smb_vwv[ 1]= 12 (0xC)
smb_vwv[ 2]= 0 (0x0)
smb_vwv[ 3]= 0 (0x0)
smb_vwv[ 4]= 56 (0x38)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 12 (0xC)
smb_vwv[ 7]= 56 (0x38)
smb_vwv[ 8]= 0 (0x0)
smb_vwv[ 9]= 0 (0x0)
smb_bcc=13
[2022/12/13 17:32:12.581365, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 01 00 00 00 7B 01 00 00 00 00 00 00 .....{.. .....
[2022/12/13 17:32:12.581423, 4, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:4245(call_trans2qfsinfo)
SMBtrans2 info_level = 512
[2022/12/13 17:32:12.584183, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 74
[2022/12/13 17:32:12.584275, 6, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x4a
[2022/12/13 17:32:12.584291, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 6 of length 78 (0 toread)
[2022/12/13 17:32:12.584311, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=74
smb_com=0x32
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=49153
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=21259
smt_wct=15
smb_vwv[ 0]= 8 (0x8)
smb_vwv[ 1]= 0 (0x0)
smb_vwv[ 2]= 2 (0x2)
smb_vwv[ 3]= 4000 (0xFA0)
smb_vwv[ 4]= 0 (0x0)
smb_vwv[ 5]= 0 (0x0)
smb_vwv[ 6]= 0 (0x0)
smb_vwv[ 7]= 0 (0x0)
smb_vwv[ 8]= 0 (0x0)
smb_vwv[ 9]= 8 (0x8)
smb_vwv[10]= 66 (0x42)
smb_vwv[11]= 0 (0x0)
smb_vwv[12]= 0 (0x0)
smb_vwv[13]= 1 (0x1)
smb_vwv[14]= 5 (0x5)
smb_bcc=9
[2022/12/13 17:32:12.584491, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../lib/util/util.c:569(dump_data)
[0000] 00 00 02 00 00 00 00 00 00 ........ .
[2022/12/13 17:32:12.584525, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBtrans2 (pid 2021378) conn 0x56481bbcf890
[2022/12/13 17:32:12.584541, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:327(change_to_user_impersonate)
change_to_user_impersonate: Skipping user change - already user
[2022/12/13 17:32:12.584575, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/uid.c:294(print_impersonation_info)
print_impersonation_info: Impersonated user: uid=(65534,65534), gid=(0,65534), cwd=[/mnt/bulk/Music]
[2022/12/13 17:32:12.584595, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/trans2.c:6063(call_trans2qfilepathinfo)
call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
[2022/12/13 17:32:12.584609, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/error.c:78(error_packet_set)
NT error packet at ../../source3/smbd/trans2.c(6071) cmd=50 (SMBtrans2) NT_STATUS_INVALID_LEVEL
[2022/12/13 17:32:12.584634, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=35
smb_com=0x32
smb_rcls=72
smb_reh=1
smb_err=49152
smb_flg=128
smb_flg2=49155
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=21259
smt_wct=0
smb_bcc=0
[2022/12/13 17:32:12.585838, 10, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 35
[2022/12/13 17:32:12.585859, 6, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x23
[2022/12/13 17:32:12.585871, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 7 of length 39 (0 toread)
[2022/12/13 17:32:12.585888, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/lib/util.c:156(show_msg)
size=35
smb_com=0x71
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=49153
smb_tid=29430
smb_pid=227
smb_uid=8683
smb_mid=21515
smt_wct=0
smb_bcc=0
[2022/12/13 17:32:12.585958, 3, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBtdis (pid 2021378) conn 0x56481bbcf890
[2022/12/13 17:32:12.585972, 4, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.585985, 5, pid=2021378, effective(65534, 65534), real(65534, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.585998, 5, pid=2021378, effective(65534, 65534), real(65534, 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
[2022/12/13 17:32:12.586040, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.586062, 4, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir)
vfs_ChDir to /mnt/bulk/Music
[2022/12/13 17:32:12.586086, 5, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir)
vfs_ChDir: vfs_ChDir got /mnt/bulk/Music
[2022/12/13 17:32:12.586127, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.586139, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.586165, 5, pid=2021378, 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
[2022/12/13 17:32:12.586188, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.586200, 2, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/service.c:1125(close_cnum)
192.168.0.203 (ipv4:192.168.0.203:33748) closed connection to service musicshare
[2022/12/13 17:32:12.586220, 4, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:938(vfs_ChDir)
vfs_ChDir to /
[2022/12/13 17:32:12.586238, 5, pid=2021378, effective(0, 0), real(0, 0), class=vfs] ../../source3/smbd/vfs.c:1000(vfs_ChDir)
vfs_ChDir: vfs_ChDir got /
[2022/12/13 17:32:12.586255, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.586266, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.586277, 5, pid=2021378, 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
[2022/12/13 17:32:12.586297, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.586318, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.586331, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_tcon_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.586347, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key B849A046
[2022/12/13 17:32:12.586366, 10, pid=2021378, 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 0x56481bbbdac0
[2022/12/13 17:32:12.586392, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key B849A046
[2022/12/13 17:32:12.586404, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_tcon_global.tdb
[2022/12/13 17:32:12.587612, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_sock.c:179(read_smb_length_return_keepalive)
got smb length of 39
[2022/12/13 17:32:12.587701, 6, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1956(process_smb)
got message type 0x0 of len 0x27
[2022/12/13 17:32:12.587718, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1958(process_smb)
Transaction 8 of length 43 (0 toread)
[2022/12/13 17:32:12.587738, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util.c:156(show_msg)
size=39
smb_com=0x74
smb_rcls=0
smb_reh=0
smb_err=0
smb_flg=0
smb_flg2=1
smb_tid=0
smb_pid=227
smb_uid=8683
smb_mid=21771
smt_wct=2
smb_vwv[ 0]= 255 (0xFF)
smb_vwv[ 1]= 0 (0x0)
smb_bcc=0
[2022/12/13 17:32:12.587827, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:1550(switch_message)
switch message SMBulogoffX (pid 2021378) conn 0x0
[2022/12/13 17:32:12.587845, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.587858, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.587916, 5, pid=2021378, 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
[2022/12/13 17:32:12.587959, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.588002, 4, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/pampass.c:486(smb_pam_start)
smb_pam_start: PAM: Init user: nobody
[2022/12/13 17:32:12.590422, 4, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/pampass.c:495(smb_pam_start)
smb_pam_start: PAM: setting rhost to: 192.168.0.203
[2022/12/13 17:32:12.590443, 4, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/pampass.c:504(smb_pam_start)
smb_pam_start: PAM: setting tty
[2022/12/13 17:32:12.590455, 4, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/pampass.c:512(smb_pam_start)
smb_pam_start: PAM: Init passed for user: nobody
[2022/12/13 17:32:12.590465, 4, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/pampass.c:649(smb_internal_pam_session)
smb_internal_pam_session: PAM: tty set to: smb/2143948342
[2022/12/13 17:32:12.591251, 4, pid=2021378, effective(0, 0), real(0, 0), class=auth] ../../source3/auth/pampass.c:468(smb_pam_end)
smb_pam_end: PAM: PAM_END OK.
[2022/12/13 17:32:12.591270, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:143(dbwrap_lock_order_lock)
dbwrap_lock_order_lock: check lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.591281, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:128(debug_lock_order)
lock order: 1:/run/samba/smbXsrv_session_global.tdb 2:<none> 3:<none> 4:<none>
[2022/12/13 17:32:12.591296, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Locking key 7FCA0E36
[2022/12/13 17:32:12.591310, 10, pid=2021378, 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 0x56481bbbe930
[2022/12/13 17:32:12.591323, 10, pid=2021378, 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
[2022/12/13 17:32:12.591341, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap.c:175(dbwrap_lock_order_unlock)
dbwrap_lock_order_unlock: release lock order 1 for /run/samba/smbXsrv_session_global.tdb
[2022/12/13 17:32:12.591351, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)
db_tdb_log_key: Unlocking key 7FCA0E36
[2022/12/13 17:32:12.591361, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/smbXsrv_session.c:1222(smbXsrv_session_destructor)
smbXsrv_session_destructor: destructing session(8683)
[2022/12/13 17:32:12.591376, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/reply.c:2688(reply_ulogoffX_done)
reply_ulogoffX_done: ulogoffX vuid=8683
[2022/12/13 17:32:12.592790, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/util_sock.c:78(read_fd_with_timeout)
read_fd_with_timeout: blocking read. EOF from client.
[2022/12/13 17:32:12.592864, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:557(receive_smb_talloc)
receive_smb_raw_talloc failed for client ptr=0x56481bbecd70,id=1,addr=ipv4:192.168.0.203:33748 read error = NT_STATUS_END_OF_FILE.
[2022/12/13 17:32:12.592893, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.592904, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.592945, 5, pid=2021378, 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
[2022/12/13 17:32:12.592978, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.593039, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.593051, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.593063, 5, pid=2021378, 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
[2022/12/13 17:32:12.593079, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.593089, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.593098, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.593106, 5, pid=2021378, 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
[2022/12/13 17:32:12.593122, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.593133, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.593142, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.593150, 5, pid=2021378, 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
[2022/12/13 17:32:12.593165, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.593175, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/process.c:3769(smbXsrv_connection_destructor)
smbXsrv_connection_destructor: xconn[ptr=0x56481bbecd70,id=1,addr=ipv4:192.168.0.203:33748]
[2022/12/13 17:32:12.593190, 4, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/sec_ctx.c:317(set_sec_ctx_internal)
setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2022/12/13 17:32:12.593199, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../libcli/security/security_token.c:47(security_token_debug)
Security token: (NULL)
[2022/12/13 17:32:12.593208, 5, pid=2021378, 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
[2022/12/13 17:32:12.593223, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/uid.c:494(smbd_change_to_root_user)
change_to_root_user: now uid=(0,0) gid=(0,0)
[2022/12/13 17:32:12.593233, 5, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/lib/messages.c:759(messaging_deregister)
Deregistering messaging pointer for type 784 - private_data=0x56481bbf2dd0
[2022/12/13 17:32:12.593300, 10, pid=2021378, effective(0, 0), real(0, 0)] ../../lib/messaging/messages_dgm_ref.c:163(msg_dgm_ref_destructor)
msg_dgm_ref_destructor: refs=(nil)
[2022/12/13 17:32:12.593419, 3, pid=2021378, effective(0, 0), real(0, 0)] ../../source3/smbd/server_exit.c:229(exit_server_common)
Server exit (failed to receive smb request)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment