[Samba] smbclient oddness

Grant Petersen grant.petersen at genericproducts.net
Wed May 20 03:16:21 UTC 2020


Sorry all,

I think I attached the wrong files. 
Apologies for the noise. Correct files attached.

again ..

these are from the logfile on the server and were in the log file named
192.168.168.13.log
192.168.168.13 is the IP address of the test client orgonon that I have
set up for this.
I have cut two sections from the log and they start at the same point
and seem to be the same until line 162;

I have attached them to this email - hope that sort of this is Ok to
do.

good one
[2020/05/20 14:28:36.463095,  4]
../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)

bad one
[2020/05/20 14:32:19.689211,  2]
../../source3/smbd/process.c:2888(deadtime_fn)

On Wed, 2020-05-20 at 14:12 +1200, Andrew Bartlett wrote:
> Are there any logs on the client or server at a higher log level?
> 
> Andrew Bartlett
> 
> On Wed, 2020-05-20 at 12:39 +1200, Grant Petersen via samba wrote:
> > I forgot to mention that using the smbclient option 
> > 
> > -A /etc/cred/authfile 
> > 
> > behaves the same way as attempting to manually enter the password
> > on
> > the command line; failing in 4.12.2 and working in 4.11.0
> > 
> > Thanks, Grant.
> > 
> > On Wed, 2020-05-20 at 12:00 +1200, Grant Petersen wrote:
> > > Hi all.
> > > 
> > > I have had this apparently inconsistent behavior in smbclinet
> > > since, around 4.11.(6?). 4.11.0 seems fine. 
> > > I am on fedora 31 so I have just been keeping smbclient at 4.11.0
> > > but
> > > that is not an option in stock fedora 32 which I would like to
> > > use
> > > now.
> > > My main problem with it is that it seems to be stopping automount
> > > working on samba shares of Fed32 clients.
> > > 
> > > Any suggestions welcome...
> > > 
> > > 
> > > This works:
> > > 
> > > [grant.petersen at orgonon ~]$ smbclient -L gnabregib  -U
> > > Enter GENERICPRODUCTS\grant.petersen's password: 
> > > 
> > >         Sharename       Type      Comment
> > >         ---------       ----      -------
> > >         tmp             Disk      Temporary file space
> > >         media           Disk      Media server file space
> > >         apps            Disk      
> > >         backups         Disk      
> > >         www             Disk      
> > >         IPC$            IPC       IPC Service (Genericproducts
> > > samba
> > > server)
> > > SMB1 disabled -- no workgroup available
> > > 
> > > 
> > > This should work exactly the same? The password prompt seems
> > > exactly
> > > the same.
> > > 
> > > [grant.petersen at orgonon ~]$ smbclient -L gnabregib  -
> > > Ugrant.petersen
> > > Enter GENERICPRODUCTS\grant.petersen's password: 
> > > session setup failed: NT_STATUS_CONNECTION_DISCONNECTED
> > > 
> > > but times out after about 1 minute to give the above error.
> > > 
> > > Confirming account name and version
> > > 
> > > [grant.petersen at orgonon ~]$ whoami
> > > grant.petersen
> > > [grant.petersen at orgonon ~]$ smbclient -V
> > > Version 4.12.2
> > > 
> > > Interestingly using the ip address of the server instead of the
> > > host
> > > name and providing the user name on the command line works.
> > > 
> > > grant.petersen at orgonon ~]$ smbclient -L 192.168.XXX.YYY  -
> > > Ugrant.petersen
> > > Enter GENERICPRODUCTS\grant.petersen's password: 
> > > 
> > >         Sharename       Type      Comment
> > >         ---------       ----      -------
> > >         tmp             Disk      Temporary file space
> > >         media           Disk      Media server file space
> > >         apps            Disk      
> > >         backups         Disk      
> > >         www             Disk      
> > >         IPC$            IPC       IPC Service (Genericproducts
> > > samba
> > > server)
> > > SMB1 disabled -- no workgroup available
> > > 
> > > 
> > > Server :
> > > [grant.petersen at gnabregib ~]$ smbd -V
> > > Version 4.12.2
> > > grant.petersen at gnabregib ~]$ cat /etc/samba/smb.conf
> > > [global]
> > >         workgroup = genericproducts
> > >         server string = Genericproducts samba server
> > >         log file = /var/log/samba/%m.log
> > >         max log size = 2000
> > >         log level = 1 
> > >         server role = standalone
> > >         security = user
> > >         guest ok = yes
> > >         guest account = xxxxxxxxx
> > >         create mask = 0664
> > >         directory mask = 0775
> > >         force create mode = 0664
> > >         force directory mode = 0775
> > >         client min protocol = smb2_02
> > >         server min protocol = smb2_02
> > > 
> > > 
> > 
> > -- 
> > Grant Petersen
> > Email:  grant.petersen at genericproducts.net
> > 
> > 
-- 
Grant Petersen
Phone:  +64 (7) 856 3399
Cell:   022 043 0351
Email:  grant.petersen at genericproducts.net
-------------- next part --------------
[2020/05/20 14:31:19.631904,  3] ../../source3/smbd/oplock.c:1413(init_oplocks)
  init_oplocks: initializing messages.
[2020/05/20 14:31:19.631978,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 774 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632021,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 778 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632061,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 770 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632099,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 801 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632138,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 787 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632177,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 779 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632216,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 15 - private_data=(nil)
[2020/05/20 14:31:19.632267,  5] ../../source3/lib/messages.c:739(messaging_register)
  Overriding messaging pointer for type 15 - private_data=(nil)
[2020/05/20 14:31:19.632310,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 16 - private_data=(nil)
[2020/05/20 14:31:19.632361,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 16 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632401,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 33 - private_data=0x565093cd5f80
[2020/05/20 14:31:19.632448,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 33 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632488,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 790 - private_data=(nil)
[2020/05/20 14:31:19.632527,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 790 - private_data=0x565093d008c0
[2020/05/20 14:31:19.632567,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 791 - private_data=(nil)
[2020/05/20 14:31:19.632606,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 1 - private_data=(nil)
[2020/05/20 14:31:19.632645,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 1 - private_data=(nil)
[2020/05/20 14:31:19.632796,  3] ../../source3/smbd/process.c:1957(process_smb)
  Transaction 0 of length 214 (0 toread)
[2020/05/20 14:31:19.632902,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:31:19.632954,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:31:19.633026,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:31:19.633115,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:31:19.633198,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:31:19.633249,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:31:19.633369,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:31:19.633405,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:31:19.633441,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:31:19.633608,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:31:19.633668,  5] ../../lib/util/debug.c:808(debug_dump_status)
  INFO: Current debug levels:
    all: 5
    tdb: 5
    printdrivers: 5
    lanman: 5
    smb: 5
    rpc_parse: 5
    rpc_srv: 5
    rpc_cli: 5
    passdb: 5
    sam: 5
    auth: 5
    winbind: 5
    vfs: 5
    idmap: 5
    quota: 5
    acls: 5
    locking: 5
    msdfs: 5
    dmapi: 5
    registry: 5
    scavenger: 5
    dns: 5
    ldb: 5
    tevent: 5
    auth_audit: 5
    auth_json_audit: 5
    kerberos: 5
    drs_repl: 5
    smb2: 5
    smb2_credits: 5
    dsdb_audit: 5
    dsdb_json_audit: 5
    dsdb_password_audit: 5
    dsdb_password_json_audit: 5
    dsdb_transaction_audit: 5
    dsdb_transaction_json_audit: 5
    dsdb_group_audit: 5
    dsdb_group_json_audit: 5
[2020/05/20 14:31:19.634345,  3] ../../source3/smbd/smb2_negprot.c:293(smbd_smb2_request_process_negprot)
  Selected protocol SMB3_11
[2020/05/20 14:31:19.634404,  5] ../../source3/auth/auth.c:549(make_auth3_context_for_ntlm)
  Making default auth method list for server role = 'standalone server', encrypt passwords = yes
[2020/05/20 14:31:19.634457,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend anonymous
[2020/05/20 14:31:19.634505,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'anonymous'
[2020/05/20 14:31:19.634542,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend sam
[2020/05/20 14:31:19.634578,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'sam'
[2020/05/20 14:31:19.634613,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend sam_ignoredomain
[2020/05/20 14:31:19.634649,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'sam_ignoredomain'
[2020/05/20 14:31:19.634685,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend sam_netlogon3
[2020/05/20 14:31:19.634721,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'sam_netlogon3'
[2020/05/20 14:31:19.634757,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend winbind
[2020/05/20 14:31:19.634804,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'winbind'
[2020/05/20 14:31:19.634840,  5] ../../source3/auth/auth.c:424(load_auth_module)
  load_auth_module: Attempting to find an auth method to match anonymous
[2020/05/20 14:31:19.634877,  5] ../../source3/auth/auth.c:449(load_auth_module)
  load_auth_module: auth method anonymous has a valid init
[2020/05/20 14:31:19.634914,  5] ../../source3/auth/auth.c:424(load_auth_module)
  load_auth_module: Attempting to find an auth method to match sam_ignoredomain
[2020/05/20 14:31:19.634960,  5] ../../source3/auth/auth.c:449(load_auth_module)
  load_auth_module: auth method sam_ignoredomain has a valid init
[2020/05/20 14:31:19.635691,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'gssapi_spnego' registered
[2020/05/20 14:31:19.635741,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'gssapi_krb5' registered
[2020/05/20 14:31:19.635781,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'gssapi_krb5_sasl' registered
[2020/05/20 14:31:19.635819,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'spnego' registered
[2020/05/20 14:31:19.635857,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'schannel' registered
[2020/05/20 14:31:19.635895,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'naclrpc_as_system' registered
[2020/05/20 14:31:19.635932,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'sasl-EXTERNAL' registered
[2020/05/20 14:31:19.635985,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'ntlmssp' registered
[2020/05/20 14:31:19.636025,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'ntlmssp_resume_ccache' registered
[2020/05/20 14:31:19.636064,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'http_basic' registered
[2020/05/20 14:31:19.636103,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'http_ntlm' registered
[2020/05/20 14:31:19.636142,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'http_negotiate' registered
[2020/05/20 14:31:19.636309,  5] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2020/05/20 14:31:19.636391,  5] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2020/05/20 14:32:19.689211,  2] ../../source3/smbd/process.c:2888(deadtime_fn)
  Closing idle connection
[2020/05/20 14:32:19.689349,  3] ../../source3/smbd/server.c:155(msg_exit_server)
  got a SHUTDOWN message
[2020/05/20 14:32:19.689426,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:32:19.689468,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:32:19.689506,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:32:19.689585,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:32:19.689630,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:32:19.689668,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:32:19.689705,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:32:19.689772,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:32:19.689817,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:32:19.689855,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:32:19.689892,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:32:19.689959,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:32:19.690006,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:32:19.690044,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:32:19.690081,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:32:19.690147,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:32:19.690203,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:32:19.690245,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:32:19.690301,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:32:19.690368,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:32:19.690780,  3] ../../source3/smbd/server_exit.c:249(exit_server_common)
  Server exit (normal exit)

-------------- next part --------------
2020/05/20 14:28:30.895148,  3] ../../source3/smbd/oplock.c:1413(init_oplocks)
  init_oplocks: initializing messages.
[2020/05/20 14:28:30.895238,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 774 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895298,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 778 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895336,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 770 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895373,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 801 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895410,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 787 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895448,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 779 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895486,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 15 - private_data=(nil)
[2020/05/20 14:28:30.895523,  5] ../../source3/lib/messages.c:739(messaging_register)
  Overriding messaging pointer for type 15 - private_data=(nil)
[2020/05/20 14:28:30.895561,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 16 - private_data=(nil)
[2020/05/20 14:28:30.895610,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 16 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895649,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 33 - private_data=0x565093cd5f80
[2020/05/20 14:28:30.895694,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 33 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895732,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 790 - private_data=(nil)
[2020/05/20 14:28:30.895769,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 790 - private_data=0x565093d008c0
[2020/05/20 14:28:30.895807,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 791 - private_data=(nil)
[2020/05/20 14:28:30.895844,  5] ../../source3/lib/messages.c:771(messaging_deregister)
  Deregistering messaging pointer for type 1 - private_data=(nil)
[2020/05/20 14:28:30.895882,  5] ../../source3/lib/messages.c:723(messaging_register)
  Registering messaging pointer for type 1 - private_data=(nil)
[2020/05/20 14:28:30.896031,  3] ../../source3/smbd/process.c:1957(process_smb)
  Transaction 0 of length 214 (0 toread)
[2020/05/20 14:28:30.896136,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:30.896184,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:30.896238,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:30.896475,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:28:30.896590,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:30.896643,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:30.896681,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:30.896719,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:30.896755,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:30.896929,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:30.897001,  5] ../../lib/util/debug.c:808(debug_dump_status)
  INFO: Current debug levels:
    all: 5
    tdb: 5
    printdrivers: 5
    lanman: 5
    smb: 5
    rpc_parse: 5
    rpc_srv: 5
    rpc_cli: 5
    passdb: 5
    sam: 5
    auth: 5
    winbind: 5
    vfs: 5
    idmap: 5
    quota: 5
    acls: 5
    locking: 5
    msdfs: 5
    dmapi: 5
    registry: 5
    scavenger: 5
    dns: 5
    ldb: 5
    tevent: 5
    auth_audit: 5
    auth_json_audit: 5
    kerberos: 5
    drs_repl: 5
    smb2: 5
    smb2_credits: 5
    dsdb_audit: 5
    dsdb_json_audit: 5
    dsdb_password_audit: 5
    dsdb_password_json_audit: 5
    dsdb_transaction_audit: 5
    dsdb_transaction_json_audit: 5
    dsdb_group_audit: 5
    dsdb_group_json_audit: 5
[2020/05/20 14:28:30.897795,  3] ../../source3/smbd/smb2_negprot.c:293(smbd_smb2_request_process_negprot)
  Selected protocol SMB3_11
[2020/05/20 14:28:30.897853,  5] ../../source3/auth/auth.c:549(make_auth3_context_for_ntlm)
  Making default auth method list for server role = 'standalone server', encrypt passwords = yes
[2020/05/20 14:28:30.897909,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend anonymous
[2020/05/20 14:28:30.897958,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'anonymous'
[2020/05/20 14:28:30.897995,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend sam
[2020/05/20 14:28:30.898031,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'sam'
[2020/05/20 14:28:30.898067,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend sam_ignoredomain
[2020/05/20 14:28:30.898103,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'sam_ignoredomain'
[2020/05/20 14:28:30.898139,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend sam_netlogon3
[2020/05/20 14:28:30.898176,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'sam_netlogon3'
[2020/05/20 14:28:30.898213,  5] ../../source3/auth/auth.c:51(smb_register_auth)
  Attempting to register auth backend winbind
[2020/05/20 14:28:30.898273,  5] ../../source3/auth/auth.c:63(smb_register_auth)
  Successfully added auth method 'winbind'
[2020/05/20 14:28:30.898312,  5] ../../source3/auth/auth.c:424(load_auth_module)
  load_auth_module: Attempting to find an auth method to match anonymous
[2020/05/20 14:28:30.898350,  5] ../../source3/auth/auth.c:449(load_auth_module)
  load_auth_module: auth method anonymous has a valid init
[2020/05/20 14:28:30.898387,  5] ../../source3/auth/auth.c:424(load_auth_module)
  load_auth_module: Attempting to find an auth method to match sam_ignoredomain
[2020/05/20 14:28:30.898434,  5] ../../source3/auth/auth.c:449(load_auth_module)
  load_auth_module: auth method sam_ignoredomain has a valid init
[2020/05/20 14:28:30.899161,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'gssapi_spnego' registered
[2020/05/20 14:28:30.899208,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'gssapi_krb5' registered
[2020/05/20 14:28:30.899248,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'gssapi_krb5_sasl' registered
[2020/05/20 14:28:30.899327,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'spnego' registered
[2020/05/20 14:28:30.899363,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'schannel' registered
[2020/05/20 14:28:30.899399,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'naclrpc_as_system' registered
[2020/05/20 14:28:30.899435,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'sasl-EXTERNAL' registered
[2020/05/20 14:28:30.899471,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'ntlmssp' registered
[2020/05/20 14:28:30.899525,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'ntlmssp_resume_ccache' registered
[2020/05/20 14:28:30.899563,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'http_basic' registered
[2020/05/20 14:28:30.899602,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'http_ntlm' registered
[2020/05/20 14:28:30.899640,  3] ../../auth/gensec/gensec_start.c:976(gensec_register)
  GENSEC backend 'http_negotiate' registered
[2020/05/20 14:28:30.899795,  5] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2020/05/20 14:28:30.899875,  5] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2020/05/20 14:28:36.463095,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.463175,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.463213,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.463311,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:28:36.463369,  5] ../../lib/dbwrap/dbwrap.c:142(dbwrap_lock_order_lock)
  dbwrap_lock_order_lock: check lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.463655,  5] ../../lib/dbwrap/dbwrap.c:171(dbwrap_lock_order_unlock)
  dbwrap_lock_order_unlock: release lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.463704,  5] ../../source3/auth/auth.c:549(make_auth3_context_for_ntlm)
  Making default auth method list for server role = 'standalone server', encrypt passwords = yes
[2020/05/20 14:28:36.463748,  5] ../../source3/auth/auth.c:424(load_auth_module)
  load_auth_module: Attempting to find an auth method to match anonymous
[2020/05/20 14:28:36.463786,  5] ../../source3/auth/auth.c:449(load_auth_module)
  load_auth_module: auth method anonymous has a valid init
[2020/05/20 14:28:36.463821,  5] ../../source3/auth/auth.c:424(load_auth_module)
  load_auth_module: Attempting to find an auth method to match sam_ignoredomain
[2020/05/20 14:28:36.463857,  5] ../../source3/auth/auth.c:449(load_auth_module)
  load_auth_module: auth method sam_ignoredomain has a valid init
[2020/05/20 14:28:36.463997,  5] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC mechanism spnego
[2020/05/20 14:28:36.464039,  5] ../../lib/dbwrap/dbwrap.c:142(dbwrap_lock_order_lock)
  dbwrap_lock_order_lock: check lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.464110,  5] ../../lib/dbwrap/dbwrap.c:171(dbwrap_lock_order_unlock)
  dbwrap_lock_order_unlock: release lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.464154,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.464194,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.464231,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.464294,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.464329,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.464448,  5] ../../auth/gensec/gensec_start.c:737(gensec_start_mech)
  Starting GENSEC submechanism ntlmssp
[2020/05/20 14:28:36.464513,  3] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2020/05/20 14:28:36.464767,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.464852,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.464892,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.464927,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.464962,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.464995,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.465073,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.465916,  5] ../../lib/dbwrap/dbwrap.c:142(dbwrap_lock_order_lock)
  dbwrap_lock_order_lock: check lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.465987,  5] ../../lib/dbwrap/dbwrap.c:171(dbwrap_lock_order_unlock)
  dbwrap_lock_order_unlock: release lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.466030,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.466065,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.466098,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.466161,  5] ../../source3/smbd/uid.c:497(smbd_change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2020/05/20 14:28:36.466205,  5] ../../lib/dbwrap/dbwrap.c:142(dbwrap_lock_order_lock)
  dbwrap_lock_order_lock: check lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.466276,  5] ../../lib/dbwrap/dbwrap.c:171(dbwrap_lock_order_unlock)
  dbwrap_lock_order_unlock: release lock order 1 for /var/lib/samba/lock/smbXsrv_session_global.tdb
[2020/05/20 14:28:36.466321,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.466358,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.466393,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.466428,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.466462,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.466546,  3] ../../auth/ntlmssp/ntlmssp_server.c:509(ntlmssp_server_preauth)
  Got user=[grant.petersen] domain=[GENERICPRODUCTS] workstation=[ORGONON] len1=24 len2=244
[2020/05/20 14:28:36.466619,  3] ../../source3/param/loadparm.c:3932(lp_load_ex)
  lp_load_ex: refreshing parameters
[2020/05/20 14:28:36.466657,  5] ../../source3/param/loadparm.c:1368(free_param_opts)
  Freeing parametrics:
[2020/05/20 14:28:36.466801,  3] ../../source3/param/loadparm.c:550(init_globals)
  Initialising global parameters
[2020/05/20 14:28:36.466980,  3] ../../source3/param/loadparm.c:2844(lp_do_section)
  Processing section "[global]"
  doing parameter workgroup = genericproducts
  doing parameter server string = Genericproducts samba server
  doing parameter log file = /var/log/samba/%m.log
  doing parameter max log size = 2000
  doing parameter log level = 5
[2020/05/20 14:28:36.467192,  5] ../../lib/util/debug.c:808(debug_dump_status)
  INFO: Current debug levels:
    all: 5
    tdb: 5
    printdrivers: 5
    lanman: 5
    smb: 5
    rpc_parse: 5
    rpc_srv: 5
    rpc_cli: 5
    passdb: 5
    sam: 5
    auth: 5
    winbind: 5
    vfs: 5
    idmap: 5
    quota: 5
    acls: 5
    locking: 5
    msdfs: 5
    dmapi: 5
    registry: 5
    scavenger: 5
    dns: 5
    ldb: 5
    tevent: 5
    auth_audit: 5
    auth_json_audit: 5
    kerberos: 5
    drs_repl: 5
    smb2: 5
    smb2_credits: 5
    dsdb_audit: 5
    dsdb_json_audit: 5
    dsdb_password_audit: 5
    dsdb_password_json_audit: 5
    dsdb_transaction_audit: 5
    dsdb_transaction_json_audit: 5
    dsdb_group_audit: 5
    dsdb_group_json_audit: 5
  doing parameter server role = standalone
  doing parameter security = user
  doing parameter guest ok = yes
  doing parameter guest account = mediashare
  doing parameter create mask = 0664
  doing parameter directory mask = 0775
  doing parameter force create mode = 0664
  doing parameter force directory mode = 0775
  doing parameter client min protocol = smb2_02
  doing parameter server min protocol = smb2_02
[2020/05/20 14:28:36.468030,  2] ../../source3/param/loadparm.c:2861(lp_do_section)
  Processing section "[tmp]"
  doing parameter comment = Temporary file space
  doing parameter path = /tmp
  doing parameter read only = No
  doing parameter guest ok = Yes
[2020/05/20 14:28:36.468199,  2] ../../source3/param/loadparm.c:2861(lp_do_section)
  Processing section "[media]"
  doing parameter comment = Media server file space
  doing parameter path = /home/mediashare/media
  doing parameter read only = no
  doing parameter create mask = 0775
  doing parameter guest ok = yes
[2020/05/20 14:28:36.468394,  2] ../../source3/param/loadparm.c:2861(lp_do_section)
  Processing section "[apps]"
  doing parameter path = /home/mediashare/apps
  doing parameter read only = No
  doing parameter guest ok = Yes
[2020/05/20 14:28:36.468528,  2] ../../source3/param/loadparm.c:2861(lp_do_section)
  Processing section "[backups]"
  doing parameter path = /home/mediashare/backups
  doing parameter read only = No
  doing parameter guest ok = Yes
[2020/05/20 14:28:36.468662,  2] ../../source3/param/loadparm.c:2861(lp_do_section)
  Processing section "[www]"
  doing parameter path = /var/www
  doing parameter read only = No
  doing parameter guest ok = Yes
[2020/05/20 14:28:36.468809,  4] ../../source3/param/loadparm.c:3974(lp_load_ex)
  pm_process() returned Yes
[2020/05/20 14:28:36.468862,  3] ../../source3/param/loadparm.c:1645(lp_add_ipc)
  adding IPC service
[2020/05/20 14:28:36.468921,  5] ../../source3/auth/auth_util.c:123(make_user_info_map)
  Mapping user [GENERICPRODUCTS]\[grant.petersen] from workstation [ORGONON]
[2020/05/20 14:28:36.468958,  5] ../../source3/auth/user_info.c:64(make_user_info)
  attempting to make a user_info for grant.petersen (grant.petersen)
[2020/05/20 14:28:36.468994,  5] ../../source3/auth/user_info.c:72(make_user_info)
  making strings for grant.petersen's user_info struct
[2020/05/20 14:28:36.469033,  5] ../../source3/auth/user_info.c:117(make_user_info)
  making blobs for grant.petersen's user_info struct
[2020/05/20 14:28:36.469071,  3] ../../source3/auth/auth.c:200(auth_check_ntlm_password)
  check_ntlm_password:  Checking password for unmapped user [GENERICPRODUCTS]\[grant.petersen]@[ORGONON] with the new password interface
[2020/05/20 14:28:36.469109,  3] ../../source3/auth/auth.c:203(auth_check_ntlm_password)
  check_ntlm_password:  mapped user is: [GENERICPRODUCTS]\[grant.petersen]@[ORGONON]
[2020/05/20 14:28:36.469145,  5] ../../lib/util/util.c:664(dump_data)
  [0000] 07 C3 FE C1 37 57 2B B7                             ....7W+. 
[2020/05/20 14:28:36.469206,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.469245,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2020/05/20 14:28:36.469303,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.469340,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.469406,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.469528,  4] ../../source3/lib/substitute.c:450(automount_server)
  Home server: gnabregib
[2020/05/20 14:28:36.469578,  4] ../../source3/lib/substitute.c:450(automount_server)
  Home server: gnabregib
[2020/05/20 14:28:36.469625,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.469665,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.469702,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.469738,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.469774,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.469879,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.469942,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.469982,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.470018,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.470058,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.470094,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.470185,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.470230,  5] ../../source3/lib/username.c:181(Get_Pwnam_alloc)
  Finding user grant.petersen
[2020/05/20 14:28:36.470278,  5] ../../source3/lib/username.c:120(Get_Pwnam_internals)
  Trying _Get_Pwnam(), username as lowercase is grant.petersen
[2020/05/20 14:28:36.470386,  5] ../../source3/lib/username.c:158(Get_Pwnam_internals)
  Get_Pwnam_internals did find user [grant.petersen]!
[2020/05/20 14:28:36.470526,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.470567,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.470605,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.470642,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.470678,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.470786,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.470844,  3] ../../source3/passdb/lookup_sid.c:1605(get_primary_group_sid)
  Forcing Primary Group to 'Domain Users' for grant.petersen
[2020/05/20 14:28:36.470887,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.470926,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.470963,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.471000,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.471035,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.471141,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.471196,  4] ../../source3/lib/substitute.c:450(automount_server)
  Home server: gnabregib
[2020/05/20 14:28:36.471245,  4] ../../source3/lib/substitute.c:450(automount_server)
  Home server: gnabregib
[2020/05/20 14:28:36.471307,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.471347,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.471383,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.471420,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.471455,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.471545,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.471613,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.471658,  4] ../../libcli/auth/ntlm_check.c:406(ntlm_password_check)
  ntlm_password_check: Checking NTLMv2 password with domain [GENERICPRODUCTS]
[2020/05/20 14:28:36.471744,  4] ../../source3/auth/check_samsec.c:183(sam_account_ok)
  sam_account_ok: Checking SMB password for user grant.petersen
[2020/05/20 14:28:36.471788,  5] ../../source3/auth/check_samsec.c:164(logon_hours_ok)
  logon_hours_ok: user grant.petersen allowed to logon at this time (Wed May 20 02:28:36 2020
  )
[2020/05/20 14:28:36.471837,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.471876,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2020/05/20 14:28:36.471912,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.471948,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.471983,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.472074,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.472119,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.472158,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2020/05/20 14:28:36.472195,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.472231,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.472279,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.472347,  5] ../../source3/lib/username.c:181(Get_Pwnam_alloc)
  Finding user grant.petersen
[2020/05/20 14:28:36.472383,  5] ../../source3/lib/username.c:120(Get_Pwnam_internals)
  Trying _Get_Pwnam(), username as lowercase is grant.petersen
[2020/05/20 14:28:36.472422,  5] ../../source3/lib/username.c:158(Get_Pwnam_internals)
  Get_Pwnam_internals did find user [grant.petersen]!
[2020/05/20 14:28:36.472466,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.472504,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.472544,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.472580,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.472627,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.472718,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.472762,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.472800,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.472837,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.472873,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.472908,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.472997,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.473042,  5] ../../source3/lib/username.c:181(Get_Pwnam_alloc)
  Finding user grant.petersen
[2020/05/20 14:28:36.473079,  5] ../../source3/lib/username.c:120(Get_Pwnam_internals)
  Trying _Get_Pwnam(), username as lowercase is grant.petersen
[2020/05/20 14:28:36.473117,  5] ../../source3/lib/username.c:158(Get_Pwnam_internals)
  Get_Pwnam_internals did find user [grant.petersen]!
[2020/05/20 14:28:36.473604,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.473641,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.473670,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.473700,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.473728,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.473808,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.473878,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.473909,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.473939,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.473968,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.473996,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.474073,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.474131,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.474162,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
[2020/05/20 14:28:36.474192,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
[2020/05/20 14:28:36.474221,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.474249,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.474344,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.474384,  5] ../../source3/auth/server_info_sam.c:121(make_server_info_sam)
  make_server_info_sam: made server info for user grant.petersen -> grant.petersen
[2020/05/20 14:28:36.474439,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.474476,  3] ../../source3/auth/auth.c:267(auth_check_ntlm_password)
  auth_check_ntlm_password: sam_ignoredomain authentication for user [grant.petersen] succeeded
[2020/05/20 14:28:36.474513,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.474544,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2020/05/20 14:28:36.474573,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.474602,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.474630,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.474694,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.474726,  5] ../../source3/auth/auth.c:294(auth_check_ntlm_password)
  check_ntlm_password:  PAM Account for user [grant.petersen] succeeded
[2020/05/20 14:28:36.474786,  3] ../../auth/auth_log.c:635(log_authentication_event_human_readable)
  Auth: [SMB2,(null)] user [GENERICPRODUCTS]\[grant.petersen] at [Wed, 20 May 2020 14:28:36.474757 NZST] with [NTLMv2] status [NT_STATUS_OK] workstation [ORGONON] remote host [ipv4:192.168.168.13:56048] became [GNABREGIB]\[grant.petersen] [S-1-5-21-1818503044-4174415067-3541754521-1000]. local host [ipv4:192.168.168.125:445] 
  {"timestamp": "2020-05-20T14:28:36.475016+1200", "type": "Authentication", "Authentication": {"version": {"major": 1, "minor": 2}, "eventId": 4624, "logonId": "0", "logonType": 3, "status": "NT_STATUS_OK", "localAddress": "ipv4:192.168.168.125:445", "remoteAddress": "ipv4:192.168.168.13:56048", "serviceDescription": "SMB2", "authDescription": null, "clientDomain": "GENERICPRODUCTS", "clientAccount": "grant.petersen", "workstation": "ORGONON", "becameAccount": "grant.petersen", "becameDomain": "GNABREGIB", "becameSid": "S-1-5-21-1818503044-4174415067-3541754521-1000", "mappedAccount": "grant.petersen", "mappedDomain": "GENERICPRODUCTS", "netlogonComputer": null, "netlogonTrustAccount": null, "netlogonNegotiateFlags": "0x00000000", "netlogonSecureChannelType": 0, "netlogonTrustAccountSid": null, "passwordType": "NTLMv2", "duration": 11284}}
[2020/05/20 14:28:36.475094,  2] ../../source3/auth/auth.c:323(auth_check_ntlm_password)
  check_ntlm_password:  authentication for user [grant.petersen] -> [grant.petersen] -> [grant.petersen] succeeded
[2020/05/20 14:28:36.475145,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.475237,  3] ../../auth/ntlmssp/ntlmssp_sign.c:623(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2020/05/20 14:28:36.475291,  3] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2020/05/20 14:28:36.475451,  3] ../../auth/ntlmssp/ntlmssp_sign.c:623(ntlmssp_sign_reset)
  NTLMSSP Sign/Seal - Initialising with flags:
[2020/05/20 14:28:36.475480,  3] ../../auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
  Got NTLMSSP neg_flags=0x62088215
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
[2020/05/20 14:28:36.475613,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.475656,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.475685,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.475714,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.475741,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.475806,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.476262,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.476300,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.476330,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.476359,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.476388,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.476471,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.476523,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.476554,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.476582,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.476611,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.476638,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.476712,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.476761,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.476792,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.476821,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.476849,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.476877,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.476950,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.476989,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477019,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.477047,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477076,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.477104,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.477182,  3] ../../source3/auth/token_util.c:688(finalize_local_nt_token)
  Failed to fetch domain sid for GENERICPRODUCTS
[2020/05/20 14:28:36.477229,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.477289,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477331,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.477360,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477389,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.477417,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.477501,  5] ../../source3/passdb/pdb_util.c:162(create_builtin_administrators)
  create_builtin_administrators: Failed to create Administrators
[2020/05/20 14:28:36.477543,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.477633,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477665,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.477693,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477720,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.477747,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.477824,  5] ../../source3/passdb/pdb_util.c:132(create_builtin_users)
  create_builtin_users: Failed to create Users
[2020/05/20 14:28:36.477865,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.477910,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477939,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.477967,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.477995,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.478022,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.478097,  5] ../../source3/passdb/pdb_util.c:205(create_builtin_guests)
  create_builtin_guests: Failed to create Guests
[2020/05/20 14:28:36.478141,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.478176,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.478206,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.478234,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.478275,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.478303,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.478536,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.478581,  4] ../../source3/lib/privileges.c:98(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-21-1818503044-4174415067-3541754521-1000]
[2020/05/20 14:28:36.478622,  4] ../../source3/lib/privileges.c:98(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-21-1818503044-4174415067-3541754521-513]
[2020/05/20 14:28:36.478661,  4] ../../source3/lib/privileges.c:98(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-22-2-1000]
[2020/05/20 14:28:36.478710,  4] ../../source3/lib/privileges.c:98(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-22-2-10]
[2020/05/20 14:28:36.478749,  4] ../../source3/lib/privileges.c:98(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-22-2-1001]
[2020/05/20 14:28:36.478790,  5] ../../source3/lib/privileges.c:178(get_privileges_for_sids)
  get_privileges_for_sids: sid = S-1-1-0
  Privilege set: 0x0
[2020/05/20 14:28:36.478837,  4] ../../source3/lib/privileges.c:98(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-2]
[2020/05/20 14:28:36.478876,  4] ../../source3/lib/privileges.c:98(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-11]
[2020/05/20 14:28:36.479002,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.479035,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.479065,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.479094,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.479123,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.479177,  5] ../../source3/passdb/pdb_interface.c:1759(lookup_global_sam_rid)
  lookup_global_sam_rid: looking up RID 513.
[2020/05/20 14:28:36.479211,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.479242,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2020/05/20 14:28:36.479329,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.479359,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.479387,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.479453,  5] ../../source3/passdb/pdb_tdb.c:658(tdbsam_getsampwrid)
  pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201.
[2020/05/20 14:28:36.479511,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.479545,  5] ../../source3/passdb/pdb_interface.c:1836(lookup_global_sam_rid)
  Can't find a unix id for an unmapped group
[2020/05/20 14:28:36.479574,  5] ../../source3/passdb/pdb_interface.c:1543(pdb_default_sid_to_id)
  SID S-1-5-21-1818503044-4174415067-3541754521-513 belongs to our domain, but there is no corresponding object in the database.
[2020/05/20 14:28:36.479620,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.479655,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.479688,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.479718,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.479747,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.479775,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.479830,  5] ../../source3/passdb/pdb_interface.c:1759(lookup_global_sam_rid)
  lookup_global_sam_rid: looking up RID 513.
[2020/05/20 14:28:36.479863,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.479894,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2020/05/20 14:28:36.479933,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2020/05/20 14:28:36.479963,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.479991,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.480054,  5] ../../source3/passdb/pdb_tdb.c:658(tdbsam_getsampwrid)
  pdb_getsampwrid (TDB): error looking up RID 513 by key RID_00000201.
[2020/05/20 14:28:36.480110,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480144,  5] ../../source3/passdb/pdb_interface.c:1836(lookup_global_sam_rid)
  Can't find a unix id for an unmapped group
[2020/05/20 14:28:36.480173,  5] ../../source3/passdb/pdb_interface.c:1543(pdb_default_sid_to_id)
  SID S-1-5-21-1818503044-4174415067-3541754521-513 belongs to our domain, but there is no corresponding object in the database.
[2020/05/20 14:28:36.480218,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480263,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480295,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480325,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480354,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.480382,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.480448,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480482,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480513,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480542,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480571,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.480599,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.480664,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480699,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480730,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480759,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480788,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.480816,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.480882,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480916,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.480947,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.480976,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.481005,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.481042,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.481107,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.481142,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.481173,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.481202,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.481232,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.481270,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.481335,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.481370,  4] ../../source3/smbd/sec_ctx.c:215(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.481400,  4] ../../source3/smbd/uid.c:565(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2020/05/20 14:28:36.481432,  4] ../../source3/smbd/sec_ctx.c:319(set_sec_ctx_internal)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2020/05/20 14:28:36.481461,  5] ../../libcli/security/security_token.c:52(security_token_debug)
  Security token: (NULL)
[2020/05/20 14:28:36.481489,  5] ../../source3/auth/token_util.c:873(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2020/05/20 14:28:36.481555,  4] ../../source3/smbd/sec_ctx.c:437(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2020/05/20 14:28:36.481623,  4] ../../auth/auth_log.c:740(log_successful_authz_event_human_readable)
  Successful AuthZ: [SMB2,NTLMSSP] user [GNABREGIB]\[grant.petersen] [S-1-5-21-1818503044-4174415067-3541754521-1000] at [Wed, 20 May 2020 14:28:36.481604 NZST] Remote host [ipv4:192.168.168.13:56048] local host [ipv4:192.168.168.125:445]
  {"timestamp": "2020-05-20T14:28:36.481684+1200", "type": "Authorization", "Authorization": {"version": {"major": 1, "minor": 1}, "localAddress": "ipv4:192.168.168.125:445", "remoteAddress": "ipv4:192.168.168.13:56048", "serviceDescription": "SMB2", "authType": "NTLMSSP", "domain": "GNABREGIB", "account": "grant.petersen", "sid": "S-1-5-21-1818503044-4174415067-3541754521-1000", "sessionId": "7aaa9e42-183e-4a35-988a-e6351549a9f0", "logonServer": "GNABREGIB", "transportProtection": "SMB", "accountFlags": "0x00000010"}}
[2020/05/20 14:28:36.481834,  5] ../../source3/lib/username.c:181(Get_Pwnam_alloc)
  Finding user grant.petersen
[2020/05/20 14:28:36.481866,  5] ../../source3/lib/username.c:120(Get_Pwnam_internals)
  Trying _Get_Pwnam(), username as lowercase is grant.petersen
[2020/05/20 14:28:36.481895,  5] ../../source3/lib/username.c:158(Get_Pwnam_internals)
  Get_Pwnam_internals did find user [grant.petersen]!
[2020/05/20 14:28:36.481924,  3] ../../source3/smbd/password.c:84(register_homes_share)
  Adding homes service for user 'grant.petersen' using home directory: '/home/grant.petersen'
[2020/05/20 14:28:36.481995,  5] ../../lib/util/debug.c:808(debug_dump_status)
  INFO: Current debug levels:
    all: 5
    tdb: 5
    printdrivers: 5
    lanman: 5
    smb: 5
    rpc_parse: 5
    rpc_srv: 5
    rpc_cli: 5
    passdb: 5
    sam: 5
    auth: 5
    winbind: 5
    vfs: 5
    idmap: 5
    quota: 5
    acls: 5
    locking: 5
    msdfs: 5
    dmapi: 5
    registry: 5
    scavenger: 5
    dns: 5
    ldb: 5
    tevent: 5
    auth_audit: 5
    auth_json_audit: 5
    kerberos: 5
    drs_repl: 5
    smb2: 5
    smb2_credits: 5
    dsdb_audit: 5
    dsdb_json_audit: 5
    dsdb_password_audit: 5
    dsdb_password_json_audit: 5
    dsdb_transaction_audit: 5
    dsdb_transaction_json_audit: 5
    dsdb_group_audit: 5
    dsdb_group_json_audit: 5



More information about the samba mailing list