[Samba] Samba and Cisco's WebVPN

Stephen Loeckle sloeckle at gmail.com
Wed Jan 31 00:45:05 GMT 2007


Hi All,

I'm posting this just in case someone can tell what's going on with
samba that would prevent this from working. Cisco has the ability to
see a smb share from their webvpn product with CIFS. We can browse
windows shares but not samba shares. The following log outputs are
from my ASA firewall. I know these are cisco logs but I'm hoping a
lightbulb will come on for someone. The first is the failed samba
browse and the second is the successful windows browse. The peculiar
thing in the failed attempt is the smb_maperr32 : no direct map for 32
bit server error (0xc0000033).

I went ahead and posted some heavy samba debug logs at the end of the
cisco logs. I don't see any specific errors in these. It's greek to me
since I'm a cisco engineer. Please let me know if I can provide any
other information. We'd rather continue with our windows removal
project and not revert back.

Thanks,

Stephen

*************************************************************************************************

asa01# ewaFormSubmit_webvpn_filecheck()
   path str   : cifs://10.7.96.43
   ctr 0, pos : 10.7.96.43
In cifs_ctx_init
In cifs_ctx_readrc_srvr
In cifs_ctx_readrc_user
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LANMAN 1.0 (6, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 8080f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb: Need username and domain for NTLMSSP
smb_iod_request :
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LANMAN 1.0 (6, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 80f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_ssnsetup : iod_state = unknown stat(3)
smb_iod_addrq :
smb_iod_sendrq : iod_state = unknown stat(4)
smb_iod_sendrq : M:0001, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0001
smb_iod_removerq :
smb_rq_reply : M:0001, P:0001, U:0064, T:ffff, E: 0:0
smb_smb_ssnsetup : 0
smb_iod_ssnsetup : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0002, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0002
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0002, P:0001, U:0064, T:0001, E: 0:0
smb_smb_treeconnect : 0
smb_t2_request_int : 0:19:16644
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0003, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0003
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_rq_reply : M:0003, P:0001, U:0064, T:0001, E: 0:0
smb_iod_removerq :
In cifs_ctx_free_int
smb_iod_addrq :
smb_iod_waitrq :
ewaFormSubmit_webvpn_filecheck()
...resuming
ewaFormServe_webvpn_filecheck()
ewaFormServe_webvpn_filecheck()
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0004, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0004
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0004, P:0001, U:0064, T:0001, E: 0:0
smb_smb_treedisconnect : 0
smb_iod_request :
smb_iod_process_message :
smb_iod_addrq :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0005, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0005
smb_iod_removerq :
smb_rq_reply : M:0005, P:0001, U:0064, T:ffff, E: 0:0
smb_smb_ssnclose : 0
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
ewaFormSubmit_webvpn_filecheck()
In cifs_ctx_init
In cifs_ctx_readrc_srvr
In cifs_ctx_readrc_user
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LANMAN 1.0 (6, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 8080f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb: Need username and domain for NTLMSSP
smb_iod_request :
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LANMAN 1.0 (6, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 80f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_ssnsetup : iod_state = unknown stat(3)
smb_iod_addrq :
smb_iod_sendrq : iod_state = unknown stat(4)
smb_iod_sendrq : M:0001, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0001
smb_iod_removerq :
smb_rq_reply : M:0001, P:0001, U:0064, T:ffff, E: 0:0
smb_smb_ssnsetup : 0
smb_iod_ssnsetup : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0002, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0002
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0002, P:0001, U:0064, T:0001, E: 0:0
smb_smb_treeconnect : 0
In cifs_ctx_free_int
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0003, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0003
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_maperr32 : no direct map for 32 bit server error (0xc0000033)
smb_rq_reply : M:0003, P:0001, U:0064, T:0001, E: 0:0
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0004, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0004
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0004, P:0001, U:0064, T:0001, E: 0:0
smb_smb_treedisconnect : 0
smb_iod_request :
smb_iod_process_message :
smb_iod_addrq :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0005, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0005
smb_iod_removerq :
smb_rq_reply : M:0005, P:0001, U:0064, T:ffff, E: 0:0
smb_smb_ssnclose : 0
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
ewaFormSubmit_webvpn_filecheck()
...resuming
ewaFormServe_webvpn_cifs_error()


*************************************************************************************************


asa01# ewaFormSubmit_webvpn_filecheck()
   path str   : 10.7.96.10
   ctr 0, pos : 10.7.96.10
In cifs_ctx_init
In cifs_ctx_readrc_srvr
In cifs_ctx_readrc_user
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LM 0.12 (7, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 8001f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb: Need username and domain for NTLMSSP
smb_iod_request :
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LM 0.12 (7, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 1f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_ssnsetup : iod_state = unknown stat(3)
smb_iod_addrq :
smb_iod_sendrq : iod_state = unknown stat(4)
smb_iod_sendrq : M:0001, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0001
smb_iod_removerq :
smb_rq_reply : M:0001, P:0001, U:0800, T:ffff, E: 0:0
smb_smb_ssnsetup : 0
smb_iod_ssnsetup : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0002, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0002
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0002, P:0001, U:0800, T:0800, E: 0:0
smb_smb_treeconnect : 0
smb_t2_request_int : 0:19:16644
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0003, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0003
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_rq_reply : M:0003, P:0001, U:0800, T:0800, E: 0:0
smb_iod_removerq :
In cifs_ctx_free_int
smb_iod_addrq :
smb_iod_waitrq :
ewaFormSubmit_webvpn_filecheck()
...resuming
ewaFormServe_webvpn_filecheck()
ewaFormServe_webvpn_filecheck()
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0004, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0004
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0004, P:0001, U:0800, T:0800, E: 0:0
smb_smb_treedisconnect : 0
smb_iod_request :
smb_iod_process_message :
smb_iod_addrq :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0005, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0005
smb_iod_removerq :
smb_rq_reply : M:0005, P:0001, U:0800, T:ffff, E: 0:0
smb_smb_ssnclose : 0
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
ewaFormSubmit_webvpn_filecheck()
In cifs_ctx_init
In cifs_ctx_readrc_srvr
In cifs_ctx_readrc_user
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LM 0.12 (7, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 8001f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb: Need username and domain for NTLMSSP
smb_iod_request :
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_request :
smb_iod_process_message :
smb_iod_negotiate : iod_state = No connect
smb_iod_negotiate : tcreate
smb_iod_negotiate : bind
smb_iod_negotiate : tconnect
smb_iod_addrq :
smb_iod_sendrq : iod_state = transport active
smb_iod_sendrq : M:0000, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0000
smb_iod_removerq :
smb_rq_reply : M:0000, P:0001, U:ffff, T:ffff, E: 0:0
smb_smb_negotiate : 0
smb_smb_negotiate : Dialect NT LM 0.12 (7, 17)
smb_smb_negotiate : TZ = 360
smb_smb_negotiate : CAPS = 1f3fd
smb_smb_negotiate : MAXMUX = 50
smb_smb_negotiate : MAXVCS = 1
smb_smb_negotiate : MAXRAW = 65536
smb_smb_negotiate : MAXTX = 16644
smb_iod_negotiate : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
smb_iod_ssnsetup : iod_state = unknown stat(3)
smb_iod_addrq :
smb_iod_sendrq : iod_state = unknown stat(4)
smb_iod_sendrq : M:0001, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0001
smb_iod_removerq :
smb_rq_reply : M:0001, P:0001, U:0800, T:ffff, E: 0:0
smb_smb_ssnsetup : 0
smb_iod_ssnsetup : completed
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0002, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0002
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0002, P:0001, U:0800, T:0800, E: 0:0
smb_smb_treeconnect : 0
In cifs_ctx_free_int
smb_t2_request_int : 0:15:16644
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0003, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0003
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_rq_reply : M:0003, P:0001, U:0800, T:0800, E: 0:0
smb_iod_removerq :
smb_iod_addrq :
smb_iod_waitrq :
smb_iod_process_message :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0004, P:0000, U:0000, T:0000
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_recvall : mid 0004
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_removerq :
smb_rq_reply : M:0004, P:0001, U:0800, T:0800, E: 0:0
smb_smb_treedisconnect : 0
smb_iod_request :
smb_iod_process_message :
smb_iod_addrq :
smb_iod_sendrq : iod_state = session established
smb_iod_sendrq : M:0005, P:0000, U:0000, T:0000
smb_iod_waitrq :
smb_iod_recvall : mid 0005
smb_iod_removerq :
smb_rq_reply : M:0005, P:0001, U:0800, T:ffff, E: 0:0
smb_smb_ssnclose : 0
smb_iod_process_message :
smb_iod_thread : going to sleep for 200 secs 0 nsecs
smb_iod_request :
smb_iod_process_message :
ewaFormSubmit_webvpn_filecheck()
...resuming
ewaFormServe_webvpn_filecheck()
ewaFormServe_webvpn_filecheck()


*************************************************************************************************


[2007/01/30 15:54:53, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:53, 5] smbd/reply.c:reply_special(543)
  init msg_type=0x81 msg_flags=0x0
[2007/01/30 15:54:53, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:53, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 168
[2007/01/30 15:54:53, 6] smbd/process.c:process_smb(1109)
  got message type 0x0 of len 0xa8
[2007/01/30 15:54:53, 3] smbd/process.c:process_smb(1110)
  Transaction 1 of length 172
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(495)
  size=168
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=18433
  smb_tid=65535
  smb_pid=1
  smb_uid=65535
  smb_mid=0
  smt_wct=0
  smb_bcc=133
[2007/01/30 15:54:53, 10] lib/util.c:dump_data(2222)
  [000] 02 50 43 20 4E 45 54 57  4F 52 4B 20 50 52 4F 47  .PC NETW ORK PROG
  [010] 52 41 4D 20 31 2E 30 00  02 4D 49 43 52 4F 53 4F  RAM 1.0. .MICROSO
  [020] 46 54 20 4E 45 54 57 4F  52 4B 53 20 31 2E 30 33  FT NETWO RKS 1.03
  [030] 00 02 4D 49 43 52 4F 53  4F 46 54 20 4E 45 54 57  ..MICROS OFT NETW
  [040] 4F 52 4B 53 20 33 2E 30  00 02 4C 41 4E 4D 41 4E  ORKS 3.0 ..LANMAN
  [050] 31 2E 30 00 02 4C 4D 31  2E 32 58 30 30 32 00 02  1.0..LM1 .2X002..
  [060] 4C 41 4E 4D 41 4E 32 2E  31 00 02 4E 54 20 4C 41  LANMAN2. 1..NT LA
  [070] 4E 4D 41 4E 20 31 2E 30  00 02 4E 54 20 4C 4D 20  NMAN 1.0 ..NT LM
  [080] 30 2E 31 32 00                                    0.12.
[2007/01/30 15:54:53, 3] smbd/process.c:switch_message(914)
  switch message SMBnegprot (pid 21707) conn 0x0
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [MICROSOFT NETWORKS 1.03]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [MICROSOFT NETWORKS 3.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [LANMAN1.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [LM1.2X002]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [LANMAN2.1]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [NT LANMAN 1.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [NT LM 0.12]
[2007/01/30 15:54:53, 10] lib/util.c:set_remote_arch(2197)
  set_remote_arch: Client arch is 'WinNT'
[2007/01/30 15:54:53, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:53, 5] smbd/connection.c:claim_connection(170)
  claiming  0
[2007/01/30 15:54:53, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_nt1(357)
  using SPNEGO
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(580)
  Selected protocol NT LANMAN 1.0
[2007/01/30 15:54:53, 5] smbd/negprot.c:reply_negprot(586)
  negprot index=6
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(495)
  size=127
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=18433
  smb_tid=65535
  smb_pid=1
  smb_uid=65535
  smb_mid=0
  smt_wct=17
  smb_vwv[ 0]=    6 (0x6)
  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]=51968 (0xCB00)
  smb_vwv[ 8]=   84 (0x54)
  smb_vwv[ 9]=64768 (0xFD00)
  smb_vwv[10]=33011 (0x80F3)
  smb_vwv[11]=32896 (0x8080)
  smb_vwv[12]=36660 (0x8F34)
  smb_vwv[13]=47429 (0xB945)
  smb_vwv[14]=51012 (0xC744)
  smb_vwv[15]=26625 (0x6801)
  smb_vwv[16]=    1 (0x1)
  smb_bcc=58
[2007/01/30 15:54:53, 10] lib/util.c:dump_data(2222)
  [000] 66 69 6C 65 31 00 00 00  00 00 00 00 00 00 00 00  file1... ........
  [010] 60 28 06 06 2B 06 01 05  05 02 A0 1E 30 1C A0 0E  `(..+... ....0...
  [020] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A3 0A  0...+... ..7.....
  [030] 30 08 A0 06 1B 04 4E 4F  4E 45                    0.....NO NE
[2007/01/30 15:54:53, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:53, 10] lib/util_sock.c:read_data(525)
  read_data: read of 4 returned 0. Error = Success
[2007/01/30 15:54:53, 10] lib/util_sock.c:receive_smb_raw(672)
  receive_smb_raw: length < 0!
[2007/01/30 15:54:53, 3] smbd/process.c:timeout_processing(1359)
  timeout_processing: End of file from client (client has disconnected).
[2007/01/30 15:54:53, 5] lib/gencache.c:gencache_shutdown(94)
  Closing cache file
[2007/01/30 15:54:53, 5] libsmb/namecache.c:namecache_shutdown(79)
  namecache_shutdown: netbios namecache closed successfully.
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:53, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to
[2007/01/30 15:54:53, 3] smbd/server.c:exit_server_common(675)
  Server exit (normal exit)
[2007/01/30 15:54:53, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:53, 5] smbd/reply.c:reply_special(543)
  init msg_type=0x81 msg_flags=0x0
[2007/01/30 15:54:53, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:53, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 168
[2007/01/30 15:54:53, 6] smbd/process.c:process_smb(1109)
  got message type 0x0 of len 0xa8
[2007/01/30 15:54:53, 3] smbd/process.c:process_smb(1110)
  Transaction 1 of length 172
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(495)
  size=168
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=16385
  smb_tid=65535
  smb_pid=1
  smb_uid=65535
  smb_mid=0
  smt_wct=0
  smb_bcc=133
[2007/01/30 15:54:53, 10] lib/util.c:dump_data(2222)
  [000] 02 50 43 20 4E 45 54 57  4F 52 4B 20 50 52 4F 47  .PC NETW ORK PROG
  [010] 52 41 4D 20 31 2E 30 00  02 4D 49 43 52 4F 53 4F  RAM 1.0. .MICROSO
  [020] 46 54 20 4E 45 54 57 4F  52 4B 53 20 31 2E 30 33  FT NETWO RKS 1.03
  [030] 00 02 4D 49 43 52 4F 53  4F 46 54 20 4E 45 54 57  ..MICROS OFT NETW
  [040] 4F 52 4B 53 20 33 2E 30  00 02 4C 41 4E 4D 41 4E  ORKS 3.0 ..LANMAN
  [050] 31 2E 30 00 02 4C 4D 31  2E 32 58 30 30 32 00 02  1.0..LM1 .2X002..
  [060] 4C 41 4E 4D 41 4E 32 2E  31 00 02 4E 54 20 4C 41  LANMAN2. 1..NT LA
  [070] 4E 4D 41 4E 20 31 2E 30  00 02 4E 54 20 4C 4D 20  NMAN 1.0 ..NT LM
  [080] 30 2E 31 32 00                                    0.12.
[2007/01/30 15:54:53, 3] smbd/process.c:switch_message(914)
  switch message SMBnegprot (pid 21708) conn 0x0
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [MICROSOFT NETWORKS 1.03]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [MICROSOFT NETWORKS 3.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [LANMAN1.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [LM1.2X002]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [LANMAN2.1]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [NT LANMAN 1.0]
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(487)
  Requested protocol [NT LM 0.12]
[2007/01/30 15:54:53, 10] lib/util.c:set_remote_arch(2197)
  set_remote_arch: Client arch is 'WinNT'
[2007/01/30 15:54:53, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:53, 5] smbd/connection.c:claim_connection(170)
  claiming  0
[2007/01/30 15:54:53, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:53, 10] smbd/negprot.c:get_challenge(42)
  get challenge: creating negprot_global_auth_context
[2007/01/30 15:54:53, 5] auth/auth.c:make_auth_context_subsystem(484)
  Making default auth method list for DC, security=user, encrypt passwords = yes
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend sam
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'sam'
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend sam_ignoredomain
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'sam_ignoredomain'
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend unix
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'unix'
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend winbind
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'winbind'
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend smbserver
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'smbserver'
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend trustdomain
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'trustdomain'
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend ntdomain
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'ntdomain'
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(47)
  Attempting to register auth backend guest
[2007/01/30 15:54:53, 5] auth/auth.c:smb_register_auth(59)
  Successfully added auth method 'guest'
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(391)
  load_auth_module: Attempting to find an auth method to match guest
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(416)
  load_auth_module: auth method guest has a valid init
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(391)
  load_auth_module: Attempting to find an auth method to match sam
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(416)
  load_auth_module: auth method sam has a valid init
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(391)
  load_auth_module: Attempting to find an auth method to match
winbind:trustdomain
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(391)
  load_auth_module: Attempting to find an auth method to match trustdomain
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(416)
  load_auth_module: auth method trustdomain has a valid init
[2007/01/30 15:54:53, 5] auth/auth.c:load_auth_module(416)
  load_auth_module: auth method winbind has a valid init
[2007/01/30 15:54:53, 10] smbd/negprot.c:get_challenge(47)
  get challenge: getting challenge
[2007/01/30 15:54:53, 5] auth/auth.c:get_ntlm_challenge(97)
  auth_get_challenge: module guest did not want to specify a challenge
[2007/01/30 15:54:53, 5] auth/auth.c:get_ntlm_challenge(97)
  auth_get_challenge: module sam did not want to specify a challenge
[2007/01/30 15:54:53, 5] auth/auth.c:get_ntlm_challenge(97)
  auth_get_challenge: module winbind did not want to specify a challenge
[2007/01/30 15:54:53, 5] auth/auth.c:get_ntlm_challenge(137)
  auth_context challenge created by random
[2007/01/30 15:54:53, 5] auth/auth.c:get_ntlm_challenge(138)
  challenge is:
[2007/01/30 15:54:53, 5] lib/util.c:dump_data(2222)
  [000] 21 42 46 01 E8 E9 4A B6                           !BF...J.
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_nt1(350)
  not using SPNEGO
[2007/01/30 15:54:53, 3] smbd/negprot.c:reply_negprot(580)
  Selected protocol NT LANMAN 1.0
[2007/01/30 15:54:53, 5] smbd/negprot.c:reply_negprot(586)
  negprot index=6
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(495)
  size=91
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=16385
  smb_tid=65535
  smb_pid=1
  smb_uid=65535
  smb_mid=0
  smt_wct=17
  smb_vwv[ 0]=    6 (0x6)
  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]=52224 (0xCC00)
  smb_vwv[ 8]=   84 (0x54)
  smb_vwv[ 9]=64768 (0xFD00)
  smb_vwv[10]=33011 (0x80F3)
  smb_vwv[11]=32768 (0x8000)
  smb_vwv[12]=36660 (0x8F34)
  smb_vwv[13]=47429 (0xB945)
  smb_vwv[14]=51012 (0xC744)
  smb_vwv[15]=26625 (0x6801)
  smb_vwv[16]= 2049 (0x801)
  smb_bcc=22
[2007/01/30 15:54:53, 10] lib/util.c:dump_data(2222)
  [000] 21 42 46 01 E8 E9 4A B6  41 00 43 00 43 00 45 00  !BF...J. A.C.C.E.
  [010] 53 00 53 00 00 00                                 S.S...
[2007/01/30 15:54:53, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:53, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 206
[2007/01/30 15:54:53, 6] smbd/process.c:process_smb(1109)
  got message type 0x0 of len 0xce
[2007/01/30 15:54:53, 3] smbd/process.c:process_smb(1110)
  Transaction 2 of length 210
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:53, 5] lib/util.c:show_msg(495)
  size=206
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=16385
  smb_tid=65535
  smb_pid=1
  smb_uid=65535
  smb_mid=1
  smt_wct=13
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=  322 (0x142)
  smb_vwv[ 5]=21708 (0x54CC)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=   24 (0x18)
  smb_vwv[ 8]=   88 (0x58)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=   88 (0x58)
  smb_vwv[12]=    0 (0x0)
  smb_bcc=145
[2007/01/30 15:54:53, 10] lib/util.c:dump_data(2222)
  [000] 76 81 1B 0D CB 48 80 B0  AA 0A 07 C0 E1 58 47 CB  v....H.. .....XG.
  [010] 49 9D F9 9D C9 CA 59 05  AF 52 52 68 4B D8 03 2F  I.....Y. .RRhK../
  [020] 7D A9 43 C2 4F 36 A1 BA  01 01 00 00 00 00 00 00  }.C.O6.. ........
  [030] 00 A3 02 6F 9F B6 9D 01  49 9D F9 9D C9 CA 59 05  ...o.... I.....Y.
  [040] 00 00 00 00 02 00 0C 00  41 00 43 00 43 00 45 00  ........ A.C.C.E.
  [050] 53 00 53 00 01 00 14 00  2A 00 53 00 4D 00 42 00  S.S..... *.S.M.B.
  [060] 53 00 45 00 52 00 56 00  45 00 52 00 00 00 00 00  S.E.R.V. E.R.....
  [070] 53 4C 4F 45 43 4B 4C 45  00 41 43 43 45 53 53 00  SLOECKLE .ACCESS.
  [080] 43 49 53 43 4F 20 41 53  41 00 4E 45 54 53 4D 42  CISCO AS A.NETSMB
  [090] 00                                                .
[2007/01/30 15:54:53, 3] smbd/process.c:switch_message(914)
  switch message SMBsesssetupX (pid 21708) conn 0x0
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:53, 3] smbd/sesssetup.c:reply_sesssetup_and_X(849)
  wct=13 flg2=0x4001
[2007/01/30 15:54:53, 3] smbd/sesssetup.c:reply_sesssetup_and_X(995)
  Domain=[ACCESS]  NativeOS=[CISCO ASA] NativeLanMan=[NETSMB]
PrimaryDomain=[null]
[2007/01/30 15:54:53, 3] smbd/sesssetup.c:reply_sesssetup_and_X(1010)
  sesssetupX:name=[ACCESS]\[SLOECKLE]@[microsage]
[2007/01/30 15:54:53, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:53, 5] auth/auth_util.c:make_user_info_map(161)
  make_user_info_map: Mapping user [ACCESS]\[SLOECKLE] from
workstation [microsage]
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/01/30 15:54:53, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] auth/auth_util.c:is_trusted_domain(2020)
  is_trusted_domain: Checking for domain trust with [ACCESS]
[2007/01/30 15:54:53, 5]
passdb/secrets.c:secrets_fetch_trusted_domain_password(339)
  secrets_fetch failed!
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:53, 10] lib/gencache.c:gencache_get(329)
  Cache entry with key = TDOM/ACCESS couldn't be found
[2007/01/30 15:54:53, 5] libsmb/trustdom_cache.c:trustdom_cache_fetch(184)
  no entry for trusted domain ACCESS found.
[2007/01/30 15:54:53, 5] auth/auth_util.c:make_user_info(75)
  attempting to make a user_info for SLOECKLE (SLOECKLE)
[2007/01/30 15:54:53, 5] auth/auth_util.c:make_user_info(85)
  making strings for SLOECKLE's user_info struct
[2007/01/30 15:54:53, 5] auth/auth_util.c:make_user_info(117)
  making blobs for SLOECKLE's user_info struct
[2007/01/30 15:54:53, 10] auth/auth_util.c:make_user_info(135)
  made an encrypted user_info for SLOECKLE (SLOECKLE)
[2007/01/30 15:54:53, 3] auth/auth.c:check_ntlm_password(221)
  check_ntlm_password:  Checking password for unmapped user
[ACCESS]\[SLOECKLE]@[microsage] with the new password interface
[2007/01/30 15:54:53, 3] auth/auth.c:check_ntlm_password(224)
  check_ntlm_password:  mapped user is: [ACCESS]\[SLOECKLE]@[microsage]
[2007/01/30 15:54:53, 10] auth/auth.c:check_ntlm_password(233)
  check_ntlm_password: auth_context challenge created by random
[2007/01/30 15:54:53, 10] auth/auth.c:check_ntlm_password(235)
  challenge is:
[2007/01/30 15:54:53, 5] lib/util.c:dump_data(2222)
  [000] 21 42 46 01 E8 E9 4A B6                           !BF...J.
[2007/01/30 15:54:53, 10] auth/auth.c:check_ntlm_password(261)
  check_ntlm_password: guest had nothing to say
[2007/01/30 15:54:53, 8] lib/util.c:is_myname(2043)
  is_myname("ACCESS") returns 0
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/01/30 15:54:53, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base => [dc=access,dc=microsage,dc=com], filter
=> [(&(uid=SLOECKLE)(objectclass=sambaSamAccount))], scope => [2]
[2007/01/30 15:54:53, 5] lib/smbldap.c:smbldap_close(1080)
  The connection to the LDAP server was closed
[2007/01/30 15:54:53, 10] lib/smbldap.c:smb_ldap_setup_conn(632)
  smb_ldap_setup_connection: ldap://10.7.96.41
[2007/01/30 15:54:53, 2] lib/smbldap.c:smbldap_open_connection(788)
  smbldap_open_connection: connection opened
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_connect_system(947)
  ldap_connect_system: Binding to ldap server ldap://10.7.96.41 as
"cn=admin,dc=access,dc=microsage,dc=com"
[2007/01/30 15:54:53, 3] lib/smbldap.c:smbldap_connect_system(992)
  ldap_connect_system: succesful connection to the LDAP server
  ldap_connect_system: LDAP server does support paged results
[2007/01/30 15:54:53, 4] lib/smbldap.c:smbldap_open(1060)
  The LDAP server is succesfully connected
[2007/01/30 15:54:53, 2] passdb/pdb_ldap.c:init_sam_from_ldap(541)
  init_sam_from_ldap: Entry found for user: sloeckle
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_username(534)
  pdb_set_username: setting username sloeckle, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_domain(557)
  pdb_set_domain: setting domain ACCESS, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_nt_username(580)
  pdb_set_nt_username: setting nt username sloeckle, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_user_sid_from_string(476)
  pdb_set_user_sid_from_string: setting user sid
S-1-5-21-4282266057-1234438341-2093462340
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_user_sid(463)
  pdb_set_user_sid: setting user sid S-1-5-21-4282266057-1234438341-2093462340
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaLogonTime] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaLogoffTime] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaKickoffTime] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaPwdCanChange] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [displayName] = [<does not exist>]
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_fullname(603)
  pdb_set_full_name: setting full name sloeckle, was
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaHomeDrive] = [<does not exist>]
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_dir_drive(672)
  pdb_set_dir_drive: setting dir drive , was NULL
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaHomePath] = [<does not exist>]
[2007/01/30 15:54:53, 4] lib/substitute.c:automount_server(407)
  Home server: 10.7.96.43
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_homedir(696)
  pdb_set_homedir: setting home dir \\10.7.96.43\sloeckle, was
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaLogonScript] = [<does not exist>]
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_logon_script(626)
  pdb_set_logon_script: setting logon script , was
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaProfilePath] = [<does not exist>]
[2007/01/30 15:54:53, 4] lib/substitute.c:automount_server(407)
  Home server: 10.7.96.43
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_profile_path(649)
  pdb_set_profile_path: setting profile path \\10.7.96.43\sloeckle\profile, was
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [description] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaUserWorkstations] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaMungedDial] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/account_pol.c:account_policy_get(340)
  account_policy_get: name: password history, val: 0
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaBadPasswordCount] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaBadPasswordTime] = [<does not exist>]
[2007/01/30 15:54:53, 10] lib/smbldap.c:smbldap_get_single_attribute(276)
  smbldap_get_single_attribute: [sambaLogonHours] = [<does not exist>]
[2007/01/30 15:54:53, 7] passdb/login_cache.c:login_cache_read(87)
  Looking up login cache for user sloeckle
[2007/01/30 15:54:53, 7] passdb/login_cache.c:login_cache_read(101)
  No cache entry found
[2007/01/30 15:54:53, 9] passdb/pdb_ldap.c:init_sam_from_ldap(898)
  No cache entry, bad count = 0, bad time = 0
[2007/01/30 15:54:53, 5] lib/username.c:Get_Pwnam_alloc(131)
  Finding user sloeckle
[2007/01/30 15:54:53, 5] lib/username.c:Get_Pwnam_internals(75)
  Trying _Get_Pwnam(), username as lowercase is sloeckle
[2007/01/30 15:54:53, 5] lib/username.c:Get_Pwnam_internals(108)
  Get_Pwnam_internals did find user [sloeckle]!
[2007/01/30 15:54:53, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(objectClass=sambaGroupMapping)(gidNumber=513))], scope => [2]
[2007/01/30 15:54:53, 2] passdb/pdb_ldap.c:init_group_from_ldap(2140)
  init_group_from_ldap: Entry found for group: 513
[2007/01/30 15:54:53, 10] passdb/lookup_sid.c:check_dom_sid_to_level(613)
  Accepting SID S-1-5-21-4282266057-1234438341-2093462340 in level 1
[2007/01/30 15:54:53, 5] passdb/pdb_interface.c:lookup_global_sam_rid(1480)
  lookup_global_sam_rid: looking up RID 513.
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/01/30 15:54:53, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base => [dc=access,dc=microsage,dc=com], filter
=> [(&(sambaSID=S-1-5-21-4282266057-1234438341-2093462340-513)(objectclass=sambaSamAccount))],
scope => [2]
[2007/01/30 15:54:53, 4] passdb/pdb_ldap.c:ldapsam_getsampwsid(1491)
  ldapsam_getsampwsid: Unable to locate SID
[S-1-5-21-4282266057-1234438341-2093462340-513] count=0
[2007/01/30 15:54:53, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-21-4282266057-1234438341-2093462340-513))],
scope => [2]
[2007/01/30 15:54:53, 2] passdb/pdb_ldap.c:init_group_from_ldap(2140)
  init_group_from_ldap: Entry found for group: 513
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:53, 5] passdb/pdb_interface.c:pdb_default_lookup_rids(1601)
  lookup_rids: Domain Users:2
[2007/01/30 15:54:53, 10] passdb/lookup_sid.c:lookup_sid(867)
  Sid S-1-5-21-4282266057-1234438341-2093462340-513 -> ACCESS\Domain Users(2)
[2007/01/30 15:54:53, 10] lib/account_pol.c:account_policy_get(340)
  account_policy_get: name: password history, val: 0
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_username(534)
  pdb_set_username: setting username sloeckle, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_domain(557)
  pdb_set_domain: setting domain ACCESS, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_nt_username(580)
  pdb_set_nt_username: setting nt username sloeckle, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_fullname(603)
  pdb_set_full_name: setting full name sloeckle, was
[2007/01/30 15:54:53, 4] lib/substitute.c:automount_server(407)
  Home server: 10.7.96.43
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_homedir(696)
  pdb_set_homedir: setting home dir \\10.7.96.43\sloeckle, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_dir_drive(672)
  pdb_set_dir_drive: setting dir drive , was NULL
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_logon_script(626)
  pdb_set_logon_script: setting logon script , was
[2007/01/30 15:54:53, 4] lib/substitute.c:automount_server(407)
  Home server: 10.7.96.43
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_profile_path(649)
  pdb_set_profile_path: setting profile path \\10.7.96.43\sloeckle\profile, was
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_workstations(739)
  pdb_set_workstations: setting workstations , was
[2007/01/30 15:54:53, 10] lib/account_pol.c:account_policy_get(340)
  account_policy_get: name: password history, val: 0
[2007/01/30 15:54:53, 10] passdb/pdb_get_set.c:pdb_set_user_sid(463)
  pdb_set_user_sid: setting user sid S-1-5-21-4282266057-1234438341-2093462340-0
[2007/01/30 15:54:53, 10] passdb/pdb_compat.c:pdb_set_user_sid_from_rid(73)
  pdb_set_user_sid_from_rid:
        setting user sid S-1-5-21-4282266057-1234438341-2093462340-0 from rid 0
[2007/01/30 15:54:53, 5] passdb/pdb_interface.c:lookup_global_sam_rid(1480)
  lookup_global_sam_rid: looking up RID 513.
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/01/30 15:54:53, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2007/01/30 15:54:53, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:53, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:53, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base => [dc=access,dc=microsage,dc=com], filter
=> [(&(sambaSID=S-1-5-21-4282266057-1234438341-2093462340-513)(objectclass=sambaSamAccount))],
scope => [2]
[2007/01/30 15:54:54, 4] passdb/pdb_ldap.c:ldapsam_getsampwsid(1491)
  ldapsam_getsampwsid: Unable to locate SID
[S-1-5-21-4282266057-1234438341-2093462340-513] count=0
[2007/01/30 15:54:54, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-21-4282266057-1234438341-2093462340-513))],
scope => [2]
[2007/01/30 15:54:54, 2] passdb/pdb_ldap.c:init_group_from_ldap(2140)
  init_group_from_ldap: Entry found for group: 513
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 10] passdb/lookup_sid.c:sid_to_gid(1324)
  sid_to_gid: S-1-5-21-4282266057-1234438341-2093462340-513 -> 513
[2007/01/30 15:54:54, 3] passdb/lookup_sid.c:store_gid_sid_cache(1059)
  store_gid_sid_cache: gid 513 in cache ->
S-1-5-21-4282266057-1234438341-2093462340-513
[2007/01/30 15:54:54, 10] passdb/pdb_get_set.c:pdb_set_group_sid(521)
  pdb_set_group_sid: setting group sid
S-1-5-21-4282266057-1234438341-2093462340-513
[2007/01/30 15:54:54, 10] passdb/pdb_compat.c:pdb_set_group_sid_from_rid(100)
  pdb_set_group_sid_from_rid:
        setting group sid
S-1-5-21-4282266057-1234438341-2093462340-513 from rid 513
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 9] passdb/passdb.c:pdb_update_autolock_flag(1413)
  pdb_update_autolock_flag: Account sloeckle not autolocked, no check needed
[2007/01/30 15:54:54, 4] libsmb/ntlm_check.c:ntlm_password_check(288)
  ntlm_password_check: Checking NTLMv2 password with domain [ACCESS]
[2007/01/30 15:54:54, 4] auth/auth_sam.c:sam_account_ok(138)
  sam_account_ok: Checking SMB password for user sloeckle
[2007/01/30 15:54:54, 5] auth/auth_sam.c:logon_hours_ok(120)
  logon_hours_ok: user sloeckle allowed to logon at this time (Tue Jan
30 21:54:54 2007
  )
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 10] lib/util_pw.c:getpwnam_alloc(76)
  Got sloeckle from pwnam_cache
[2007/01/30 15:54:54, 10] lib/util_pw.c:getpwnam_alloc(76)
  Got sloeckle from pwnam_cache
[2007/01/30 15:54:54, 10] lib/system_smbd.c:sys_getgrouplist(125)
  sys_getgrouplist: user [sloeckle]
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2007/01/30 15:54:54, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 3] passdb/lookup_sid.c:fetch_sid_from_gid_cache(995)
  fetch sid from gid cache 513 -> S-1-5-21-4282266057-1234438341-2093462340-513
[2007/01/30 15:54:54, 5] auth/auth_util.c:make_server_info_sam(625)
  make_server_info_sam: made server info for user sloeckle -> sloeckle
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 3] auth/auth.c:check_ntlm_password(270)
  check_ntlm_password: sam authentication for user [SLOECKLE] succeeded
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth.c:check_ntlm_password(296)
  check_ntlm_password:  PAM Account for user [sloeckle] succeeded
[2007/01/30 15:54:54, 2] auth/auth.c:check_ntlm_password(309)
  check_ntlm_password:  authentication for user [SLOECKLE] ->
[SLOECKLE] -> [sloeckle] succeeded
[2007/01/30 15:54:54, 5] auth/auth_util.c:free_user_info(1867)
  attempting to free (and zero) a user_info structure
[2007/01/30 15:54:54, 10] auth/auth_util.c:free_user_info(1871)
  structure was created for SLOECKLE
[2007/01/30 15:54:54, 3] passdb/lookup_sid.c:fetch_gid_from_cache(1015)
  fetch gid from cache 544 -> S-1-5-32-544
[2007/01/30 15:54:54, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-32-545))], scope =>
[2]
[2007/01/30 15:54:54, 4] passdb/pdb_ldap.c:ldapsam_getgroup(2217)
  ldapsam_getgroup: Did not find group
[2007/01/30 15:54:54, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(|(objectclass=sambaGroupMapping)(sambaGroupType=4))(|(sambaSIDList=S-1-5-21-4282266057-1234438341-2093462340)(sambaSIDList=S-1-5-21-4282266057-1234438341-2093462340-513)(sambaSIDList=S-1-1-0)(sambaSIDList=S-1-5-2)(sambaSIDList=S-1-5-11)(sambaSIDList=S-1-22-2-513)))],
scope => [2]
[2007/01/30 15:54:54, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(|(objectclass=sambaGroupMapping)(sambaGroupType=4))(|(sambaSIDList=S-1-5-21-4282266057-1234438341-2093462340)(sambaSIDList=S-1-5-21-4282266057-1234438341-2093462340-513)(sambaSIDList=S-1-1-0)(sambaSIDList=S-1-5-2)(sambaSIDList=S-1-5-11)(sambaSIDList=S-1-22-2-513)))],
scope => [2]
[2007/01/30 15:54:54, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID
[S-1-5-21-4282266057-1234438341-2093462340]
[2007/01/30 15:54:54, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID
[S-1-5-21-4282266057-1234438341-2093462340-513]
[2007/01/30 15:54:54, 5] lib/privileges.c:get_privileges_for_sids(459)
  get_privileges_for_sids: sid = S-1-1-0
  Privilege set:
  SE_PRIV  0x0 0x0 0x0 0x0
[2007/01/30 15:54:54, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID [S-1-5-2]
[2007/01/30 15:54:54, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID [S-1-5-11]
[2007/01/30 15:54:54, 3] lib/privileges.c:get_privileges(261)
  get_privileges: No privileges assigned to SID [S-1-22-2-513]
[2007/01/30 15:54:54, 3] passdb/lookup_sid.c:fetch_gid_from_cache(1015)
  fetch gid from cache 513 -> S-1-5-21-4282266057-1234438341-2093462340-513
[2007/01/30 15:54:54, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(objectClass=sambaGroupMapping)(sambaSID=S-1-1-0))], scope => [2]
[2007/01/30 15:54:54, 4] passdb/pdb_ldap.c:ldapsam_getgroup(2217)
  ldapsam_getgroup: Did not find group
[2007/01/30 15:54:54, 10] auth/auth_util.c:create_local_token(1023)
  Could not convert SID S-1-1-0 to gid, ignoring it
[2007/01/30 15:54:54, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-2))], scope => [2]
[2007/01/30 15:54:54, 4] passdb/pdb_ldap.c:ldapsam_getgroup(2217)
  ldapsam_getgroup: Did not find group
[2007/01/30 15:54:54, 10] auth/auth_util.c:create_local_token(1023)
  Could not convert SID S-1-5-2 to gid, ignoring it
[2007/01/30 15:54:54, 5] lib/smbldap.c:smbldap_search_ext(1179)
  smbldap_search_ext: base =>
[ou=Group,dc=access,dc=microsage,dc=com], filter =>
[(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-11))], scope => [2]
[2007/01/30 15:54:54, 4] passdb/pdb_ldap.c:ldapsam_getgroup(2217)
  ldapsam_getgroup: Did not find group
[2007/01/30 15:54:54, 10] auth/auth_util.c:create_local_token(1023)
  Could not convert SID S-1-5-11 to gid, ignoring it
[2007/01/30 15:54:54, 10] passdb/lookup_sid.c:sid_to_gid(1324)
  sid_to_gid: S-1-22-2-513 -> 513
[2007/01/30 15:54:54, 10] auth/auth_util.c:debug_nt_user_token(454)
  NT user token of user S-1-5-21-4282266057-1234438341-2093462340
  contains 6 SIDs
  SID[  0]: S-1-5-21-4282266057-1234438341-2093462340
  SID[  1]: S-1-5-21-4282266057-1234438341-2093462340-513
  SID[  2]: S-1-1-0
  SID[  3]: S-1-5-2
  SID[  4]: S-1-5-11
  SID[  5]: S-1-22-2-513
  SE_PRIV  0x0 0x0 0x0 0x0
[2007/01/30 15:54:54, 10] smbd/password.c:register_vuid(186)
  register_vuid: allocated vuid = 100
[2007/01/30 15:54:54, 10] lib/util_pw.c:getpwnam_alloc(76)
  Got sloeckle from pwnam_cache
[2007/01/30 15:54:54, 10] smbd/password.c:register_vuid(277)
  register_vuid: (1001,513) sloeckle SLOECKLE ACCESS guest=0
[2007/01/30 15:54:54, 3] smbd/password.c:register_vuid(280)
  User name: sloeckle   Real name: sloeckle
[2007/01/30 15:54:54, 3] smbd/password.c:register_vuid(301)
  UNIX uid 1001 is UNIX user sloeckle, and will be vuid 100
[2007/01/30 15:54:54, 7] param/loadparm.c:lp_servicenumber(5120)
  lp_servicenumber: couldn't find sloeckle
[2007/01/30 15:54:54, 3] smbd/password.c:register_vuid(332)
  Adding homes service for user 'sloeckle' using home directory:
'/home/users/sloeckle'
[2007/01/30 15:54:54, 8] param/loadparm.c:add_a_service(2503)
  add_a_service: Creating snum = 4 for sloeckle
[2007/01/30 15:54:54, 10] param/loadparm.c:hash_a_service(2550)
  hash_a_service: hashing index 4 for service name sloeckle
[2007/01/30 15:54:54, 3] param/loadparm.c:lp_add_home(2596)
  adding home's share [sloeckle] for user 'sloeckle' at '/home/users/sloeckle'
[2007/01/30 15:54:54, 6] param/loadparm.c:lp_file_list_changed(3006)
  lp_file_list_changed()
  file /etc/samba/smb.conf -> /etc/samba/smb.conf  last mod_time: Tue
Jan 30 15:34:48 2007

[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=67
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=16385
  smb_tid=65535
  smb_pid=1
  smb_uid=100
  smb_mid=1
  smt_wct=3
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_bcc=26
[2007/01/30 15:54:54, 10] lib/util.c:dump_data(2222)
  [000] 55 6E 69 78 00 53 61 6D  62 61 20 33 2E 30 2E 32  Unix.Sam ba 3.0.2
  [010] 33 64 00 41 43 43 45 53  53 00                    3d.ACCES S.
[2007/01/30 15:54:54, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 68
[2007/01/30 15:54:54, 6] smbd/process.c:process_smb(1109)
  got message type 0x0 of len 0x44
[2007/01/30 15:54:54, 3] smbd/process.c:process_smb(1110)
  Transaction 3 of length 72
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=68
  smb_com=0x75
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=16385
  smb_tid=65535
  smb_pid=1
  smb_uid=100
  smb_mid=2
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    1 (0x1)
  smb_bcc=25
[2007/01/30 15:54:54, 10] lib/util.c:dump_data(2222)
  [000] 00 5C 5C 2A 53 4D 42 53  45 52 56 45 52 5C 49 50  .\\*SMBS ERVER\IP
  [010] 43 24 00 3F 3F 3F 3F 3F  00                       C$.????? .
[2007/01/30 15:54:54, 3] smbd/process.c:switch_message(914)
  switch message SMBtconX (pid 21708) conn 0x0
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:54, 4] smbd/reply.c:reply_tcon_and_X(668)
  Client requested device type [?????] for share [IPC$]
[2007/01/30 15:54:54, 5] smbd/service.c:make_connection(1125)
  making a connection to 'normal' service ipc$
[2007/01/30 15:54:54, 10] smbd/share_access.c:user_ok_token(229)
  user_ok_token: share IPC$ is ok for unix user sloeckle
[2007/01/30 15:54:54, 5] lib/username.c:Get_Pwnam_alloc(131)
  Finding user sloeckle
[2007/01/30 15:54:54, 5] lib/username.c:Get_Pwnam_internals(75)
  Trying _Get_Pwnam(), username as lowercase is sloeckle
[2007/01/30 15:54:54, 10] lib/util_pw.c:getpwnam_alloc(76)
  Got sloeckle from pwnam_cache
[2007/01/30 15:54:54, 5] lib/username.c:Get_Pwnam_internals(108)
  Get_Pwnam_internals did find user [sloeckle]!
[2007/01/30 15:54:54, 10] smbd/service.c:set_conn_connectpath(122)
  set_conn_connectpath: service IPC$, connectpath = /tmp
[2007/01/30 15:54:54, 3] smbd/service.c:make_connection_snum(761)
  Connect path is '/tmp' for service [IPC$]
[2007/01/30 15:54:54, 4] lib/sharesec.c:get_share_security(130)
  get_share_security: using default secdesc for IPC$
[2007/01/30 15:54:54, 10] lib/util_seaccess.c:se_map_generic(176)
  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
[2007/01/30 15:54:54, 10] lib/util_seaccess.c:se_access_check(233)
  se_access_check: requested access 0x00000002, for NT token with 6
entries and first sid S-1-5-21-4282266057-1234438341-2093462340.
[2007/01/30 15:54:54, 3] lib/util_seaccess.c:se_access_check(250)
[2007/01/30 15:54:54, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-4282266057-1234438341-2093462340
  se_access_check: also S-1-5-21-4282266057-1234438341-2093462340-513
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
  se_access_check: also S-1-22-2-513
  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask =
101f01ff, current desired = 2
[2007/01/30 15:54:54, 5] lib/util_seaccess.c:se_access_check(308)
  se_access_check: access (2) granted.
[2007/01/30 15:54:54, 3] smbd/vfs.c:vfs_init_default(219)
  Initialising default vfs hooks
[2007/01/30 15:54:54, 5] smbd/connection.c:claim_connection(170)
  claiming IPC$ 0
[2007/01/30 15:54:54, 10] smbd/share_access.c:user_ok_token(229)
  user_ok_token: share IPC$ is ok for unix user sloeckle
[2007/01/30 15:54:54, 10] smbd/share_access.c:is_share_read_only_for_token(271)
  is_share_read_only_for_user: share IPC$ is read-only for unix user sloeckle
[2007/01/30 15:54:54, 4] lib/sharesec.c:get_share_security(130)
  get_share_security: using default secdesc for IPC$
[2007/01/30 15:54:54, 10] lib/util_seaccess.c:se_map_generic(176)
  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
[2007/01/30 15:54:54, 10] lib/util_seaccess.c:se_access_check(233)
  se_access_check: requested access 0x00000001, for NT token with 6
entries and first sid S-1-5-21-4282266057-1234438341-2093462340.
[2007/01/30 15:54:54, 3] lib/util_seaccess.c:se_access_check(250)
[2007/01/30 15:54:54, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-5-21-4282266057-1234438341-2093462340
  se_access_check: also S-1-5-21-4282266057-1234438341-2093462340-513
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
  se_access_check: also S-1-22-2-513
  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask =
101f01ff, current desired = 1
[2007/01/30 15:54:54, 5] lib/util_seaccess.c:se_access_check(308)
  se_access_check: access (1) granted.
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (1001, 513) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(454)
  NT user token of user S-1-5-21-4282266057-1234438341-2093462340
  contains 6 SIDs
  SID[  0]: S-1-5-21-4282266057-1234438341-2093462340
  SID[  1]: S-1-5-21-4282266057-1234438341-2093462340-513
  SID[  2]: S-1-1-0
  SID[  3]: S-1-5-2
  SID[  4]: S-1-5-11
  SID[  5]: S-1-22-2-513
  SE_PRIV  0x0 0x0 0x0 0x0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 1001
  Primary group is 513 and contains 1 supplementary groups
  Group[  0]: 513
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_user(260)
  change_to_user uid=(1001,1001) gid=(0,513)
[2007/01/30 15:54:54, 3] smbd/service.c:make_connection_snum(950)
  microsage (10.7.96.2) connect to service IPC$ initially as user
sloeckle (uid=1001, gid=513) (pid 21708)
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:54, 2] smbd/reply.c:reply_tcon_and_X(711)
  Serving IPC$ as a Dfs root
[2007/01/30 15:54:54, 3] smbd/reply.c:reply_tcon_and_X(716)
  tconX service=IPC$
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=46
  smb_com=0x75
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=16385
  smb_tid=1
  smb_pid=1
  smb_uid=100
  smb_mid=2
  smt_wct=3
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    3 (0x3)
  smb_bcc=5
[2007/01/30 15:54:54, 10] lib/util.c:dump_data(2222)
  [000] 49 50 43 00 00                                    IPC..
[2007/01/30 15:54:54, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 95
[2007/01/30 15:54:54, 6] smbd/process.c:process_smb(1109)
  got message type 0x0 of len 0x5f
[2007/01/30 15:54:54, 3] smbd/process.c:process_smb(1110)
  Transaction 4 of length 99
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=95
  smb_com=0x25
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=20481
  smb_tid=1
  smb_pid=1
  smb_uid=100
  smb_mid=3
  smt_wct=14
  smb_vwv[ 0]=   19 (0x13)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=   19 (0x13)
  smb_vwv[ 3]=65504 (0xFFE0)
  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]=   19 (0x13)
  smb_vwv[10]=   76 (0x4C)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    0 (0x0)
  smb_bcc=32
[2007/01/30 15:54:54, 10] lib/util.c:dump_data(2222)
  [000] 5C 50 49 50 45 5C 4C 41  4E 4D 41 4E 00 00 00 57  \PIPE\LA NMAN...W
  [010] 72 4C 65 68 00 42 31 33  42 57 7A 00 01 00 E0 FF  rLeh.B13 BWz.....
[2007/01/30 15:54:54, 3] smbd/process.c:switch_message(914)
  switch message SMBtrans (pid 21708) conn 0x83f8640
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (1001, 513) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(454)
  NT user token of user S-1-5-21-4282266057-1234438341-2093462340
  contains 6 SIDs
  SID[  0]: S-1-5-21-4282266057-1234438341-2093462340
  SID[  1]: S-1-5-21-4282266057-1234438341-2093462340-513
  SID[  2]: S-1-1-0
  SID[  3]: S-1-5-2
  SID[  4]: S-1-5-11
  SID[  5]: S-1-22-2-513
  SE_PRIV  0x0 0x0 0x0 0x0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 1001
  Primary group is 513 and contains 1 supplementary groups
  Group[  0]: 513
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_user(260)
  change_to_user uid=(1001,1001) gid=(0,513)
[2007/01/30 15:54:54, 4] smbd/vfs.c:vfs_ChDir(741)
  vfs_ChDir to /tmp
[2007/01/30 15:54:54, 3] smbd/ipc.c:handle_trans(373)
  trans <\PIPE\LANMAN> data=0 params=19 setup=0
[2007/01/30 15:54:54, 5] smbd/ipc.c:handle_trans(404)
  calling named_pipe
[2007/01/30 15:54:54, 3] smbd/ipc.c:named_pipe(340)
  named pipe command on <LANMAN> name
[2007/01/30 15:54:54, 3] smbd/lanman.c:api_reply(4029)
  Got API command 0 of form <WrLeh> <B13BWz>
(tdscnt=0,tpscnt=19,mdrcnt=65504,mprcnt=19)
[2007/01/30 15:54:54, 3] smbd/lanman.c:api_reply(4033)
  Doing RNetShareEnum
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:push_sec_ctx(208)
  push_sec_ctx(1001, 513) : sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 3] smbd/uid.c:push_conn_ctx(345)
  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:pop_sec_ctx(339)
  pop_sec_ctx (1001, 513) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 3] smbd/lanman.c:api_RNetShareEnum(1724)
  RNetShareEnum gave 3 entries of 3 (1 65504 136 65504)
[2007/01/30 15:54:54, 5] smbd/ipc.c:copy_trans_params_and_data(60)
  copy_trans_params_and_data: params[0..8] data[0..136]
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=200
  smb_com=0x25
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=16385
  smb_tid=1
  smb_pid=1
  smb_uid=100
  smb_mid=3
  smt_wct=10
  smb_vwv[ 0]=    8 (0x8)
  smb_vwv[ 1]=  136 (0x88)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    8 (0x8)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=  136 (0x88)
  smb_vwv[ 7]=   64 (0x40)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=145
[2007/01/30 15:54:54, 10] lib/util.c:dump_data(2222)
  [000] 00 00 00 00 00 03 00 03  00 70 72 69 6E 74 24 00  ........ .print$.
  [010] 00 00 00 00 00 00 00 00  00 3C 00 00 00 49 50 43  ........ .<...IPC
  [020] 24 00 00 00 00 00 00 00  00 00 00 03 00 4C 00 00  $....... .....L..
  [030] 00 73 6C 6F 65 63 6B 6C  65 00 00 00 00 00 00 00  .sloeckl e.......
  [040] 00 77 00 00 00 50 72 69  6E 74 65 72 20 44 72 69  .w...Pri nter Dri
  [050] 76 65 72 73 00 49 50 43  20 53 65 72 76 69 63 65  vers.IPC  Service
  [060] 20 28 66 69 6C 65 31 20  73 65 72 76 65 72 20 28   (file1  server (
  [070] 53 61 6D 62 61 20 33 2E  30 2E 32 33 64 29 29 00  Samba 3. 0.23d)).
  [080] 48 6F 6D 65 20 44 69 72  65 63 74 6F 72 69 65 73  Home Dir ectories
  [090] 00                                                .
[2007/01/30 15:54:54, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 35
[2007/01/30 15:54:54, 6] smbd/process.c:process_smb(1109)
  got message type 0x0 of len 0x23
[2007/01/30 15:54:54, 3] smbd/process.c:process_smb(1110)
  Transaction 5 of length 39
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=35
  smb_com=0x71
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=20481
  smb_tid=1
  smb_pid=1
  smb_uid=100
  smb_mid=4
  smt_wct=0
  smb_bcc=0
[2007/01/30 15:54:54, 3] smbd/process.c:switch_message(914)
  switch message SMBtdis (pid 21708) conn 0x83f8640
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:54, 3] smbd/service.c:close_cnum(1150)
  microsage (10.7.96.2) closed connection to service IPC$
[2007/01/30 15:54:54, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to IPC$
[2007/01/30 15:54:54, 4] smbd/vfs.c:vfs_ChDir(741)
  vfs_ChDir to /
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=35
  smb_com=0x71
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=16385
  smb_tid=1
  smb_pid=1
  smb_uid=100
  smb_mid=4
  smt_wct=0
  smb_bcc=0
[2007/01/30 15:54:54, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:54, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 39
[2007/01/30 15:54:54, 6] smbd/process.c:process_smb(1109)
  got message type 0x0 of len 0x27
[2007/01/30 15:54:54, 3] smbd/process.c:process_smb(1110)
  Transaction 6 of length 43
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=39
  smb_com=0x74
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=16385
  smb_tid=65535
  smb_pid=1
  smb_uid=100
  smb_mid=5
  smt_wct=2
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_bcc=0
[2007/01/30 15:54:54, 3] smbd/process.c:switch_message(914)
  switch message SMBulogoffX (pid 21708) conn 0x0
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:54, 3] smbd/reply.c:reply_ulogoffX(1618)
  ulogoffX vuid=100
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(485)
[2007/01/30 15:54:54, 5] lib/util.c:show_msg(495)
  size=39
  smb_com=0x74
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=16385
  smb_tid=65535
  smb_pid=1
  smb_uid=100
  smb_mid=5
  smt_wct=2
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_bcc=0
[2007/01/30 15:54:54, 10] smbd/process.c:setup_select_timeout(1284)
  change_notify_timeout: -1
[2007/01/30 15:54:54, 10] lib/util_sock.c:read_data(525)
  read_data: read of 4 returned 0. Error = Success
[2007/01/30 15:54:54, 10] lib/util_sock.c:receive_smb_raw(672)
  receive_smb_raw: length < 0!
[2007/01/30 15:54:54, 3] smbd/process.c:timeout_processing(1359)
  timeout_processing: End of file from client (client has disconnected).
[2007/01/30 15:54:54, 5] lib/gencache.c:gencache_shutdown(94)
  Closing cache file
[2007/01/30 15:54:54, 5] libsmb/namecache.c:namecache_shutdown(79)
  namecache_shutdown: netbios namecache closed successfully.
[2007/01/30 15:54:54, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2007/01/30 15:54:54, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2007/01/30 15:54:54, 5] smbd/uid.c:change_to_root_user(275)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2007/01/30 15:54:54, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to
[2007/01/30 15:54:54, 3] smbd/server.c:exit_server_common(675)
  Server exit (normal exit)


More information about the samba mailing list