Attachment 4108 Details for Bug 6297 – log for samba 3.3.4, to replace the previous log for 3.3.3

log for samba 3.3.4, to replace the previous log for 3.3.3

smb-3.3.4.log (text/plain), 71.98 KB, created by anonymous on 2009-05-03 20:14:06 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: anonymous

Created: 2009-05-03 20:14:06 UTC

Size: 71.98 KB

patch

obsolete

>[2009/05/04 07:52:10,  3] smbd/oplock.c:init_oplocks(912)
>  init_oplocks: initializing messages.
>[2009/05/04 07:52:10,  3] smbd/oplock_linux.c:linux_init_kernel_oplocks(241)
>  Linux kernel oplocks enabled
>[2009/05/04 07:52:10,  3] lib/access.c:only_ipaddrs_in_list(362)
>  only_ipaddrs_in_list: list has non-ip address (147.8.101.)
>[2009/05/04 07:52:10,  3] lib/access.c:check_access(396)
>  check_access: hostnames in host allow/deny list.
>[2009/05/04 07:52:10,  2] lib/access.c:check_access(406)
>  Allowed connection from x.hku.hk (147.8.101.93)
>[2009/05/04 07:52:10,  3] smbd/process.c:process_smb(1554)
>  Transaction 0 of length 194 (0 toread)
>[2009/05/04 07:52:10,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnegprot (pid 5424) conn 0x0
>[2009/05/04 07:52:10,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [PC NETWORK PROGRAM 1.0]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [MICROSOFT NETWORKS 1.03]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [MICROSOFT NETWORKS 3.0]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [LANMAN1.0]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [LM1.2X002]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [DOS LANMAN2.1]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [LANMAN2.1]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [Samba]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [NT LANMAN 1.0]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [NT LM 0.12]
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_nt1(392)
>  using SPNEGO
>[2009/05/04 07:52:10,  3] smbd/negprot.c:reply_negprot(674)
>  Selected protocol NT LANMAN 1.0
>[2009/05/04 07:52:12,  3] smbd/process.c:process_smb(1554)
>  Transaction 1 of length 164 (0 toread)
>[2009/05/04 07:52:12,  3] smbd/process.c:switch_message(1378)
>  switch message SMBsesssetupX (pid 5424) conn 0x0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
>  wct=12 flg2=0xc801
>[2009/05/04 07:52:12,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
>  Doing spnego session setup
>[2009/05/04 07:52:12,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
>  NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
>[2009/05/04 07:52:12,  3] smbd/sesssetup.c:reply_spnego_negotiate(802)
>  reply_spnego_negotiate: Got secblob of size 45
>[2009/05/04 07:52:12,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
>  Got NTLMSSP neg_flags=0x60088215
>[2009/05/04 07:52:12,  3] smbd/process.c:process_smb(1554)
>  Transaction 2 of length 262 (0 toread)
>[2009/05/04 07:52:12,  3] smbd/process.c:switch_message(1378)
>  switch message SMBsesssetupX (pid 5424) conn 0x0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
>  wct=12 flg2=0xc801
>[2009/05/04 07:52:12,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
>  Doing spnego session setup
>[2009/05/04 07:52:12,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
>  NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
>[2009/05/04 07:52:12,  3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
>  Got user=[user2] domain=[WORKGROUP] workstation=[X093] len1=24 len2=24
>[2009/05/04 07:52:12,  3] auth/auth.c:check_ntlm_password(220)
>  check_ntlm_password:  Checking password for unmapped user [WORKGROUP]\[user2]@[X093] with the new password interface
>[2009/05/04 07:52:12,  3] auth/auth.c:check_ntlm_password(223)
>  check_ntlm_password:  mapped user is: [X093]\[user2]@[X093]
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] auth/auth.c:check_ntlm_password(269)
>  check_ntlm_password: sam authentication for user [user2] succeeded
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  2] auth/auth.c:check_ntlm_password(308)
>  check_ntlm_password:  authentication for user [user2] -> [user2] -> [user2] succeeded
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] auth/token_util.c:create_local_nt_token(433)
>  Failed to fetch domain sid for WORKGROUP
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] auth/token_util.c:create_local_nt_token(464)
>  Failed to fetch domain sid for WORKGROUP
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-5-21-3903661550-1695780401-2097954093-1218]
>[2009/05/04 07:52:12,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-22-2-100]
>[2009/05/04 07:52:12,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-5-2]
>[2009/05/04 07:52:12,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-5-11]
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(337)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2009/05/04 07:52:12,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
>  Got NTLMSSP neg_flags=0x60088215
>[2009/05/04 07:52:12,  3] smbd/password.c:register_existing_vuid(289)
>  register_existing_vuid: User name: user2	Real name: 
>[2009/05/04 07:52:12,  3] smbd/password.c:register_existing_vuid(299)
>  register_existing_vuid: UNIX uid 109 is UNIX user user2, and will be vuid 100
>[2009/05/04 07:52:12,  3] smbd/password.c:register_homes_share(231)
>  Adding homes service for user 'user2' using home directory: '/home/user2'
>[2009/05/04 07:52:12,  3] smbd/process.c:process_smb(1554)
>  Transaction 3 of length 92 (0 toread)
>[2009/05/04 07:52:12,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtconX (pid 5424) conn 0x0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/access.c:only_ipaddrs_in_list(362)
>  only_ipaddrs_in_list: list has non-ip address (147.8.101.)
>[2009/05/04 07:52:12,  3] lib/access.c:check_access(396)
>  check_access: hostnames in host allow/deny list.
>[2009/05/04 07:52:12,  2] lib/access.c:check_access(406)
>  Allowed connection from 147.8.101.93 (147.8.101.93)
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/service.c:make_connection_snum(871)
>  Connect path is '/tmp' for service [IPC$]
>[2009/05/04 07:52:12,  3] smbd/vfs.c:vfs_init_default(96)
>  Initialising default vfs hooks
>[2009/05/04 07:52:12,  3] smbd/vfs.c:vfs_init_custom(130)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (109, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/service.c:make_connection_snum(1111)
>  x093 (147.8.101.93) connect to service IPC$ initially as user user2 (uid=109, gid=100) (pid 5424)
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/reply.c:reply_tcon_and_X(794)
>  tconX service=IPC$ 
>[2009/05/04 07:52:12,  3] smbd/process.c:process_smb(1554)
>  Transaction 4 of length 110 (0 toread)
>[2009/05/04 07:52:12,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 5424) conn 0x80661bc0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (109, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/msdfs.c:get_referred_path(813)
>  get_referred_path: |TMP| in dfs path \147.8.101.93\TMP is not a dfs root.
>[2009/05/04 07:52:12,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/trans2.c(7299) cmd=50 (SMBtrans2) NT_STATUS_NOT_FOUND
>[2009/05/04 07:52:12,  3] smbd/process.c:process_smb(1554)
>  Transaction 5 of length 39 (0 toread)
>[2009/05/04 07:52:12,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtdis (pid 5424) conn 0x80661bc0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/service.c:close_cnum(1323)
>  x093 (147.8.101.93) closed connection to service IPC$
>[2009/05/04 07:52:12,  3] smbd/connection.c:yield_connection(31)
>  Yielding connection to IPC$
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/process.c:process_smb(1554)
>  Transaction 6 of length 92 (0 toread)
>[2009/05/04 07:52:12,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtconX (pid 5424) conn 0x0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/access.c:only_ipaddrs_in_list(362)
>  only_ipaddrs_in_list: list has non-ip address (147.8.101.)
>[2009/05/04 07:52:12,  3] lib/access.c:check_access(396)
>  check_access: hostnames in host allow/deny list.
>[2009/05/04 07:52:12,  2] lib/access.c:check_access(406)
>  Allowed connection from 147.8.101.93 (147.8.101.93)
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/service.c:make_connection_snum(871)
>  Connect path is '/tmp' for service [TMP]
>[2009/05/04 07:52:12,  3] smbd/vfs.c:vfs_init_default(96)
>  Initialising default vfs hooks
>[2009/05/04 07:52:12,  3] smbd/vfs.c:vfs_init_custom(130)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (109, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  1] smbd/service.c:make_connection_snum(1111)
>  x093 (147.8.101.93) connect to service TMP initially as user user2 (uid=109, gid=100) (pid 5424)
>[2009/05/04 07:52:12,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:12,  3] smbd/reply.c:reply_tcon_and_X(794)
>  tconX service=TMP 
>[2009/05/04 07:52:16,  3] smbd/process.c:process_smb(1554)
>  Transaction 7 of length 98 (0 toread)
>[2009/05/04 07:52:16,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 5424) conn 0x80661bc0
>[2009/05/04 07:52:16,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (109, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:16,  3] smbd/trans2.c:call_trans2qfilepathinfo(3943)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 257
>[2009/05/04 07:52:16,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo test_dir (fnum = -1) level=257 call=5 total_data=0
>[2009/05/04 07:52:21,  3] smbd/process.c:process_smb(1554)
>  Transaction 8 of length 118 (0 toread)
>[2009/05/04 07:52:21,  3] smbd/process.c:switch_message(1378)
>  switch message SMBopenX (pid 5424) conn 0x80661bc0
>[2009/05/04 07:52:21,  3] smbd/dosmode.c:unix_mode(124)
>  unix_mode(test_dir/test_file.txt) returning 0666
>[2009/05/04 07:52:21,  2] smbd/open.c:open_file(551)
>  user2 opened file test_dir/test_file.txt read=Yes write=Yes (numopen=1)
>[2009/05/04 07:52:21,  3] smbd/process.c:process_smb(1554)
>  Transaction 9 of length 70 (0 toread)
>[2009/05/04 07:52:21,  3] smbd/process.c:switch_message(1378)
>  switch message SMBwriteX (pid 5424) conn 0x80661bc0
>[2009/05/04 07:52:21,  3] lib/util.c:fcntl_getlock(2085)
>  fcntl_getlock: fd 26 is returned info 2 pid 0
>[2009/05/04 07:52:21,  3] smbd/oplock.c:initial_break_processing(299)
>  initial_break_processing: called for 305:680006/1
>  Current oplocks_open (exclusive = 0, levelII = 0)
>[2009/05/04 07:52:21,  3] smbd/oplock.c:process_oplock_async_level2_break_message(438)
>  process_oplock_async_level2_break_message: downgrading fake level 2 oplock.
>[2009/05/04 07:52:21,  3] smbd/reply.c:reply_write_and_X(4136)
>  writeX fnum=12117 num=2 wrote=2
>[2009/05/04 07:52:21,  3] smbd/process.c:process_smb(1554)
>  Transaction 10 of length 45 (0 toread)
>[2009/05/04 07:52:21,  3] smbd/process.c:switch_message(1378)
>  switch message SMBclose (pid 5424) conn 0x80661bc0
>[2009/05/04 07:52:21,  3] smbd/reply.c:reply_close(4353)
>  close fd=26 fnum=12117 (numopen=1)
>[2009/05/04 07:52:21,  3] locking/locking.c:get_share_mode_lock(825)
>  fill_share_mode_lock failed
>[2009/05/04 07:52:21,  2] smbd/close.c:close_normal_file(606)
>  user2 closed file test_dir/test_file.txt (numopen=0) NT_STATUS_OK
>[2009/05/04 07:52:24,  3] smbd/process.c:process_smb(1554)
>  Transaction 11 of length 39 (0 toread)
>[2009/05/04 07:52:24,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtdis (pid 5424) conn 0x80661bc0
>[2009/05/04 07:52:24,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:24,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:24,  1] smbd/service.c:close_cnum(1323)
>  x093 (147.8.101.93) closed connection to service TMP
>[2009/05/04 07:52:24,  3] smbd/connection.c:yield_connection(31)
>  Yielding connection to TMP
>[2009/05/04 07:52:24,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:24,  3] smbd/process.c:smbd_process(1930)
>  receive_message_or_smb failed: NT_STATUS_END_OF_FILE, exiting
>[2009/05/04 07:52:24,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:24,  3] smbd/connection.c:yield_connection(31)
>  Yielding connection to 
>[2009/05/04 07:52:24,  3] smbd/server.c:exit_server_common(971)
>  Server exit (normal exit)
>[2009/05/04 07:52:28,  3] smbd/oplock.c:init_oplocks(912)
>  init_oplocks: initializing messages.
>[2009/05/04 07:52:28,  3] smbd/oplock_linux.c:linux_init_kernel_oplocks(241)
>  Linux kernel oplocks enabled
>[2009/05/04 07:52:28,  3] lib/access.c:only_ipaddrs_in_list(362)
>  only_ipaddrs_in_list: list has non-ip address (147.8.101.)
>[2009/05/04 07:52:28,  3] lib/access.c:check_access(396)
>  check_access: hostnames in host allow/deny list.
>[2009/05/04 07:52:28,  2] lib/access.c:check_access(406)
>  Allowed connection from x.hku.hk (147.8.101.93)
>[2009/05/04 07:52:28,  3] smbd/process.c:process_smb(1554)
>  Transaction 0 of length 194 (0 toread)
>[2009/05/04 07:52:28,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnegprot (pid 5426) conn 0x0
>[2009/05/04 07:52:28,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [PC NETWORK PROGRAM 1.0]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [MICROSOFT NETWORKS 1.03]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [MICROSOFT NETWORKS 3.0]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [LANMAN1.0]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [LM1.2X002]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [DOS LANMAN2.1]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [LANMAN2.1]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [Samba]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [NT LANMAN 1.0]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(569)
>  Requested protocol [NT LM 0.12]
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_nt1(392)
>  using SPNEGO
>[2009/05/04 07:52:28,  3] smbd/negprot.c:reply_negprot(674)
>  Selected protocol NT LANMAN 1.0
>[2009/05/04 07:52:30,  3] smbd/process.c:process_smb(1554)
>  Transaction 1 of length 164 (0 toread)
>[2009/05/04 07:52:30,  3] smbd/process.c:switch_message(1378)
>  switch message SMBsesssetupX (pid 5426) conn 0x0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
>  wct=12 flg2=0xc801
>[2009/05/04 07:52:30,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
>  Doing spnego session setup
>[2009/05/04 07:52:30,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
>  NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
>[2009/05/04 07:52:30,  3] smbd/sesssetup.c:reply_spnego_negotiate(802)
>  reply_spnego_negotiate: Got secblob of size 45
>[2009/05/04 07:52:30,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
>  Got NTLMSSP neg_flags=0x60088215
>[2009/05/04 07:52:30,  3] smbd/process.c:process_smb(1554)
>  Transaction 2 of length 262 (0 toread)
>[2009/05/04 07:52:30,  3] smbd/process.c:switch_message(1378)
>  switch message SMBsesssetupX (pid 5426) conn 0x0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1412)
>  wct=12 flg2=0xc801
>[2009/05/04 07:52:30,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1175)
>  Doing spnego session setup
>[2009/05/04 07:52:30,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1210)
>  NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
>[2009/05/04 07:52:30,  3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
>  Got user=[user1] domain=[WORKGROUP] workstation=[X093] len1=24 len2=24
>[2009/05/04 07:52:30,  3] auth/auth.c:check_ntlm_password(220)
>  check_ntlm_password:  Checking password for unmapped user [WORKGROUP]\[user1]@[X093] with the new password interface
>[2009/05/04 07:52:30,  3] auth/auth.c:check_ntlm_password(223)
>  check_ntlm_password:  mapped user is: [X093]\[user1]@[X093]
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] auth/auth.c:check_ntlm_password(269)
>  check_ntlm_password: sam authentication for user [user1] succeeded
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  2] auth/auth.c:check_ntlm_password(308)
>  check_ntlm_password:  authentication for user [user1] -> [user1] -> [user1] succeeded
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] auth/token_util.c:create_local_nt_token(433)
>  Failed to fetch domain sid for WORKGROUP
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] auth/token_util.c:create_local_nt_token(464)
>  Failed to fetch domain sid for WORKGROUP
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-5-21-3903661550-1695780401-2097954093-1216]
>[2009/05/04 07:52:30,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-22-2-100]
>[2009/05/04 07:52:30,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-5-2]
>[2009/05/04 07:52:30,  3] lib/privileges.c:get_privileges(63)
>  get_privileges: No privileges assigned to SID [S-1-5-11]
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] libsmb/ntlmssp_sign.c:ntlmssp_sign_init(337)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2009/05/04 07:52:30,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
>  Got NTLMSSP neg_flags=0x60088215
>[2009/05/04 07:52:30,  3] smbd/password.c:register_existing_vuid(289)
>  register_existing_vuid: User name: user1	Real name: 
>[2009/05/04 07:52:30,  3] smbd/password.c:register_existing_vuid(299)
>  register_existing_vuid: UNIX uid 108 is UNIX user user1, and will be vuid 100
>[2009/05/04 07:52:30,  3] smbd/password.c:register_homes_share(231)
>  Adding homes service for user 'user1' using home directory: '/home/user1'
>[2009/05/04 07:52:30,  3] smbd/process.c:process_smb(1554)
>  Transaction 3 of length 92 (0 toread)
>[2009/05/04 07:52:30,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtconX (pid 5426) conn 0x0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/access.c:only_ipaddrs_in_list(362)
>  only_ipaddrs_in_list: list has non-ip address (147.8.101.)
>[2009/05/04 07:52:30,  3] lib/access.c:check_access(396)
>  check_access: hostnames in host allow/deny list.
>[2009/05/04 07:52:30,  2] lib/access.c:check_access(406)
>  Allowed connection from 147.8.101.93 (147.8.101.93)
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/service.c:make_connection_snum(871)
>  Connect path is '/tmp' for service [IPC$]
>[2009/05/04 07:52:30,  3] smbd/vfs.c:vfs_init_default(96)
>  Initialising default vfs hooks
>[2009/05/04 07:52:30,  3] smbd/vfs.c:vfs_init_custom(130)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (108, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/service.c:make_connection_snum(1111)
>  x093 (147.8.101.93) connect to service IPC$ initially as user user1 (uid=108, gid=100) (pid 5426)
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/reply.c:reply_tcon_and_X(794)
>  tconX service=IPC$ 
>[2009/05/04 07:52:30,  3] smbd/process.c:process_smb(1554)
>  Transaction 4 of length 110 (0 toread)
>[2009/05/04 07:52:30,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 5426) conn 0x80661bc0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (108, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/msdfs.c:get_referred_path(813)
>  get_referred_path: |TMP| in dfs path \147.8.101.93\TMP is not a dfs root.
>[2009/05/04 07:52:30,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/trans2.c(7299) cmd=50 (SMBtrans2) NT_STATUS_NOT_FOUND
>[2009/05/04 07:52:30,  3] smbd/process.c:process_smb(1554)
>  Transaction 5 of length 39 (0 toread)
>[2009/05/04 07:52:30,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtdis (pid 5426) conn 0x80661bc0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/service.c:close_cnum(1323)
>  x093 (147.8.101.93) closed connection to service IPC$
>[2009/05/04 07:52:30,  3] smbd/connection.c:yield_connection(31)
>  Yielding connection to IPC$
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/process.c:process_smb(1554)
>  Transaction 6 of length 92 (0 toread)
>[2009/05/04 07:52:30,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtconX (pid 5426) conn 0x0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/access.c:only_ipaddrs_in_list(362)
>  only_ipaddrs_in_list: list has non-ip address (147.8.101.)
>[2009/05/04 07:52:30,  3] lib/access.c:check_access(396)
>  check_access: hostnames in host allow/deny list.
>[2009/05/04 07:52:30,  2] lib/access.c:check_access(406)
>  Allowed connection from 147.8.101.93 (147.8.101.93)
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/service.c:make_connection_snum(871)
>  Connect path is '/tmp' for service [TMP]
>[2009/05/04 07:52:30,  3] smbd/vfs.c:vfs_init_default(96)
>  Initialising default vfs hooks
>[2009/05/04 07:52:30,  3] smbd/vfs.c:vfs_init_custom(130)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid root does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid nobody does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] lib/util_sid.c:string_to_sid(228)
>  string_to_sid: Sid @users does not start with 'S-'.
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (108, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  1] smbd/service.c:make_connection_snum(1111)
>  x093 (147.8.101.93) connect to service TMP initially as user user1 (uid=108, gid=100) (pid 5426)
>[2009/05/04 07:52:30,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:30,  3] smbd/reply.c:reply_tcon_and_X(794)
>  tconX service=TMP 
>[2009/05/04 07:52:34,  3] smbd/process.c:process_smb(1554)
>  Transaction 7 of length 98 (0 toread)
>[2009/05/04 07:52:34,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 5426) conn 0x80661bc0
>[2009/05/04 07:52:34,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (108, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:34,  3] smbd/trans2.c:call_trans2qfilepathinfo(3943)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 257
>[2009/05/04 07:52:34,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo test_dir (fnum = -1) level=257 call=5 total_data=0
>[2009/05/04 07:52:39,  3] smbd/process.c:process_smb(1554)
>  Transaction 8 of length 57 (0 toread)
>[2009/05/04 07:52:39,  3] smbd/process.c:switch_message(1378)
>  switch message SMBecho (pid 5426) conn 0x0
>[2009/05/04 07:52:39,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:39,  3] smbd/reply.c:reply_echo(4664)
>  echo 1 times
>[2009/05/04 07:52:41,  3] smbd/process.c:process_smb(1554)
>  Transaction 9 of length 132 (0 toread)
>[2009/05/04 07:52:41,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 5426) conn 0x80661bc0
>[2009/05/04 07:52:41,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (108, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:41,  3] smbd/trans2.c:call_trans2findfirst(1926)
>  call_trans2findfirst: dirtype = 6, maxentries = 1366, close_after_first=0, close_if_end = 1 requires_resume_key = 1 level = 0x104, max_data_bytes = 16644
>[2009/05/04 07:52:41,  3] smbd/dir.c:dptr_create(518)
>  creating new dirptr 256 for path test_dir, expect_close = 1
>[2009/05/04 07:52:41,  3] smbd/process.c:process_smb(1554)
>  Transaction 10 of length 90 (0 toread)
>[2009/05/04 07:52:41,  3] smbd/process.c:switch_message(1378)
>  switch message SMBunlink (pid 5426) conn 0x80661bc0
>[2009/05/04 07:52:41,  3] smbd/reply.c:reply_unlink(2633)
>  reply_unlink : test_dir/test_file.txt
>[2009/05/04 07:52:41,  3] smbd/dosmode.c:unix_mode(124)
>  unix_mode(test_dir/test_file.txt) returning 0666
>[2009/05/04 07:52:41,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(108, 100) : sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:41,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
>[2009/05/04 07:52:41,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:41,  3] smbd/sec_ctx.c:push_sec_ctx(224)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:41,  3] smbd/uid.c:push_conn_ctx(399)
>  push_conn_ctx(100) : conn_ctx_stack_ndx = 1
>[2009/05/04 07:52:41,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2009/05/04 07:52:41,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/05/04 07:52:41,  3] smbd/sec_ctx.c:pop_sec_ctx(432)
>  pop_sec_ctx (108, 100) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:41,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/reply.c(2643) cmd=6 (SMBunlink) NT_STATUS_ACCESS_DENIED
>[2009/05/04 07:52:42,  3] smbd/process.c:process_smb(1554)
>  Transaction 11 of length 39 (0 toread)
>[2009/05/04 07:52:42,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtdis (pid 5426) conn 0x80661bc0
>[2009/05/04 07:52:42,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:42,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:42,  1] smbd/service.c:close_cnum(1323)
>  x093 (147.8.101.93) closed connection to service TMP
>[2009/05/04 07:52:42,  3] smbd/connection.c:yield_connection(31)
>  Yielding connection to TMP
>[2009/05/04 07:52:42,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:42,  3] smbd/process.c:smbd_process(1930)
>  receive_message_or_smb failed: NT_STATUS_END_OF_FILE, exiting
>[2009/05/04 07:52:42,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/05/04 07:52:42,  3] smbd/connection.c:yield_connection(31)
>  Yielding connection to 
>[2009/05/04 07:52:42,  3] smbd/server.c:exit_server_common(971)
>  Server exit (normal exit)

Actions: View

Attachments on bug 6297: 4090 | 4107 | 4108 | 4124 | 4125 | 4172 | 4265 | 4271 | 4272 | 4273 | 4274 | 4275 | 4278