Attachment 6627 Details for Bug 8251 – Client log

Client log

2011-06-26-log.CLIENT.txt (text/plain), 36.12 KB, created by Michael Eitelwein on 2011-06-26 15:47:04 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Michael Eitelwein

Created: 2011-06-26 15:47:04 UTC

Size: 36.12 KB

patch

obsolete

>[2011/06/26 17:38:26.135196,  3] smbd/process.c:1485(process_smb)
>  Transaction 0 of length 194 (0 toread)
>[2011/06/26 17:38:26.135355,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnegprot (pid 1799) conn 0x0
>[2011/06/26 17:38:26.135466,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.137312,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [PC NETWORK PROGRAM 1.0]
>[2011/06/26 17:38:26.137412,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [MICROSOFT NETWORKS 1.03]
>[2011/06/26 17:38:26.137446,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [MICROSOFT NETWORKS 3.0]
>[2011/06/26 17:38:26.137506,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [LANMAN1.0]
>[2011/06/26 17:38:26.137540,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [LM1.2X002]
>[2011/06/26 17:38:26.137571,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [DOS LANMAN2.1]
>[2011/06/26 17:38:26.137642,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [LANMAN2.1]
>[2011/06/26 17:38:26.137676,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [Samba]
>[2011/06/26 17:38:26.137706,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [NT LANMAN 1.0]
>[2011/06/26 17:38:26.137737,  3] smbd/negprot.c:586(reply_negprot)
>  Requested protocol [NT LM 0.12]
>[2011/06/26 17:38:26.138444,  3] smbd/negprot.c:404(reply_nt1)
>  using SPNEGO
>[2011/06/26 17:38:26.138489,  3] smbd/negprot.c:691(reply_negprot)
>  Selected protocol NT LANMAN 1.0
>[2011/06/26 17:38:26.144320,  3] smbd/process.c:1485(process_smb)
>  Transaction 1 of length 172 (0 toread)
>[2011/06/26 17:38:26.144457,  3] smbd/process.c:1294(switch_message)
>  switch message SMBsesssetupX (pid 1799) conn 0x0
>[2011/06/26 17:38:26.144491,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.144610,  3] smbd/sesssetup.c:1435(reply_sesssetup_and_X)
>  wct=12 flg2=0xc801
>[2011/06/26 17:38:26.144692,  3] smbd/sesssetup.c:1189(reply_sesssetup_and_X_spnego)
>  Doing spnego session setup
>[2011/06/26 17:38:26.144732,  3] smbd/sesssetup.c:1231(reply_sesssetup_and_X_spnego)
>  NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
>[2011/06/26 17:38:26.144868,  3] smbd/sesssetup.c:805(reply_spnego_negotiate)
>  reply_spnego_negotiate: Got secblob of size 53
>[2011/06/26 17:38:26.145308,  3] libsmb/ntlmssp.c:65(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088215
>[2011/06/26 17:38:26.158535,  3] smbd/process.c:1485(process_smb)
>  Transaction 2 of length 282 (0 toread)
>[2011/06/26 17:38:26.158619,  3] smbd/process.c:1294(switch_message)
>  switch message SMBsesssetupX (pid 1799) conn 0x0
>[2011/06/26 17:38:26.158654,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.158710,  3] smbd/sesssetup.c:1435(reply_sesssetup_and_X)
>  wct=12 flg2=0xc801
>[2011/06/26 17:38:26.158743,  3] smbd/sesssetup.c:1189(reply_sesssetup_and_X_spnego)
>  Doing spnego session setup
>[2011/06/26 17:38:26.158778,  3] smbd/sesssetup.c:1231(reply_sesssetup_and_X_spnego)
>  NativeOS=[Unix] NativeLanMan=[Samba] PrimaryDomain=[]
>[2011/06/26 17:38:26.158879,  3] libsmb/ntlmssp.c:747(ntlmssp_server_auth)
>  Got user=[michael] domain=[EITELWEIN] workstation=[UBUNTU-SAMBA] len1=24 len2=24
>[2011/06/26 17:38:26.159099,  3] auth/auth.c:216(check_ntlm_password)
>  check_ntlm_password:  Checking password for unmapped user [EITELWEIN]\[michael]@[UBUNTU-SAMBA] with the new password interface
>[2011/06/26 17:38:26.159145,  3] auth/auth.c:219(check_ntlm_password)
>  check_ntlm_password:  mapped user is: [UBUNTU-SAMBA]\[michael]@[UBUNTU-SAMBA]
>[2011/06/26 17:38:26.159211,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.159276,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.159328,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.159717,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.159788,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.159818,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.159980,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.160078,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.160113,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.160140,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.160212,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.160773,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.160825,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.160854,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.161432,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.161533,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.161568,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.161600,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.161650,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.161723,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.161756,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.161784,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.161834,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.161927,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.161958,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.161987,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.162049,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
>[2011/06/26 17:38:26.162082,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.162110,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
>[2011/06/26 17:38:26.162329,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.162374,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.162422,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.162705,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.162738,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.162767,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.162815,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.162850,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.162879,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.162907,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.163196,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.163232,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.163282,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.163368,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.163427,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.163456,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.163484,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.163557,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.163613,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.163642,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.163673,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.163774,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.163833,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164004,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164035,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164113,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164171,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164201,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164228,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164329,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164387,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164417,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164445,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164525,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164581,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164610,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164638,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164710,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164765,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164794,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164822,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.164918,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.164977,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165006,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165034,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165111,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165167,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165196,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165224,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165312,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165369,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165398,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165426,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165526,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165586,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165615,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165643,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165716,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165772,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165801,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165829,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.165926,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.165984,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.166013,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.166041,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.166211,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.166285,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.166316,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.166344,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.166417,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.166463,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.166497,  3] auth/auth.c:265(check_ntlm_password)
>  check_ntlm_password: sam authentication for user [michael] succeeded
>[2011/06/26 17:38:26.166530,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.166559,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.166587,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.282557,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.282639,  2] auth/auth.c:304(check_ntlm_password)
>  check_ntlm_password:  authentication for user [michael] -> [michael] -> [michael] succeeded
>[2011/06/26 17:38:26.282733,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.282752,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.282769,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.282846,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.282864,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.282879,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.282894,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.282975,  3] auth/token_util.c:436(create_local_nt_token)
>  Failed to fetch domain sid for EITELWEIN
>[2011/06/26 17:38:26.283031,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.283069,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.283085,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.283100,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.283153,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.283171,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.283186,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.283201,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.283225,  3] auth/token_util.c:467(create_local_nt_token)
>  Failed to fetch domain sid for EITELWEIN
>[2011/06/26 17:38:26.283246,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.283263,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.283278,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.283292,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.284025,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.284087,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-21-1958073264-4072893850-2984764155-3006]
>[2011/06/26 17:38:26.284115,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-100]
>[2011/06/26 17:38:26.284143,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-2]
>[2011/06/26 17:38:26.284164,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-11]
>[2011/06/26 17:38:26.284186,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1000]
>[2011/06/26 17:38:26.284208,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1001]
>[2011/06/26 17:38:26.284231,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1002]
>[2011/06/26 17:38:26.284254,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1003]
>[2011/06/26 17:38:26.284277,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1004]
>[2011/06/26 17:38:26.284300,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1005]
>[2011/06/26 17:38:26.284323,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1006]
>[2011/06/26 17:38:26.284346,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1007]
>[2011/06/26 17:38:26.284370,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1008]
>[2011/06/26 17:38:26.284393,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1009]
>[2011/06/26 17:38:26.284415,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1010]
>[2011/06/26 17:38:26.284439,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1012]
>[2011/06/26 17:38:26.284462,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1013]
>[2011/06/26 17:38:26.284485,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1014]
>[2011/06/26 17:38:26.284507,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-22-2-1015]
>[2011/06/26 17:38:26.284554,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.284570,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.284587,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.284641,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.284676,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.284692,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.284706,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.284757,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.284791,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.284807,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.284821,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.284872,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.284954,  3] libsmb/ntlmssp_sign.c:343(ntlmssp_sign_init)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2011/06/26 17:38:26.284972,  3] libsmb/ntlmssp.c:65(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0x60088215
>[2011/06/26 17:38:26.285035,  3] smbd/password.c:282(register_existing_vuid)
>  register_existing_vuid: User name: michael	Real name: Michael Eitelwein,,,,
>[2011/06/26 17:38:26.285064,  3] smbd/password.c:292(register_existing_vuid)
>  register_existing_vuid: UNIX uid 1003 is UNIX user michael, and will be vuid 100
>[2011/06/26 17:38:26.289838,  3] smbd/password.c:223(register_homes_share)
>  Adding homes service for user 'michael' using home directory: '/home/michael'
>[2011/06/26 17:38:26.290079,  3] param/loadparm.c:6265(lp_add_home)
>  adding home's share [michael] for user 'michael' at '/srv/smbhome/%S'
>[2011/06/26 17:38:26.290636,  3] smbd/process.c:1485(process_smb)
>  Transaction 3 of length 90 (0 toread)
>[2011/06/26 17:38:26.290687,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtconX (pid 1799) conn 0x0
>[2011/06/26 17:38:26.290705,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.290860,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid @familie does not start with 'S-'.
>[2011/06/26 17:38:26.291112,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291139,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291155,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291237,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291338,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291357,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291372,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291403,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291424,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291440,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291454,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291482,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291529,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291546,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291578,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291610,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291666,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291682,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291697,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291719,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.291735,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291749,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.291820,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.291841,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.291894,  3] smbd/service.c:807(make_connection_snum)
>  Connect path is '/srv/eitelwein' for service [eitelwein]
>[2011/06/26 17:38:26.291984,  3] smbd/vfs.c:97(vfs_init_default)
>  Initialising default vfs hooks
>[2011/06/26 17:38:26.292037,  3] smbd/vfs.c:122(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2011/06/26 17:38:26.292406,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid @familie does not start with 'S-'.
>[2011/06/26 17:38:26.292446,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292464,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292479,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292534,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292592,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292610,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292625,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292652,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292671,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292686,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292701,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292728,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292772,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292789,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292804,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292831,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292879,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292895,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.292910,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292933,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.292950,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.292965,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.293045,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.293067,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.293090,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (1003, 100) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.293138,  1] smbd/service.c:1070(make_connection_snum)
>  ubuntu-samba (192.168.123.192) connect to service eitelwein initially as user michael (uid=1003, gid=100) (pid 1799)
>[2011/06/26 17:38:26.293163,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.293192,  3] smbd/reply.c:846(reply_tcon_and_X)
>  tconX service=EITELWEIN 
>[2011/06/26 17:38:26.293647,  3] smbd/process.c:1485(process_smb)
>  Transaction 4 of length 96 (0 toread)
>[2011/06/26 17:38:26.293695,  3] smbd/process.c:1294(switch_message)
>  switch message SMBopenX (pid 1799) conn 0x7fa9ab8a0190
>[2011/06/26 17:38:26.293716,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (1003, 100) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.293954,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [scanner.dat] [/mnt/data1/eitelwein]
>[2011/06/26 17:38:26.293990,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: scanner.dat reduced to /mnt/data1/eitelwein/scanner.dat
>[2011/06/26 17:38:26.294036,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [scanner.dat] [/mnt/data1/eitelwein]
>[2011/06/26 17:38:26.294059,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: scanner.dat reduced to /mnt/data1/eitelwein/scanner.dat
>[2011/06/26 17:38:26.294121,  2] smbd/dosmode.c:98(unix_mode)
>  unix_mode(scanner.dat) inheriting from .
>[2011/06/26 17:38:26.294142,  2] smbd/dosmode.c:121(unix_mode)
>  unix_mode(scanner.dat) inherit mode 40770
>[2011/06/26 17:38:26.294159,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(scanner.dat) returning 0760
>[2011/06/26 17:38:26.294176,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [scanner.dat] [/mnt/data1/eitelwein]
>[2011/06/26 17:38:26.294196,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: scanner.dat reduced to /mnt/data1/eitelwein/scanner.dat
>[2011/06/26 17:38:26.294614,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(1003, 100) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.294644,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.294661,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.294698,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.294716,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(100) : conn_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.294732,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.294787,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 3
>[2011/06/26 17:38:26.294806,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(100) : conn_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.294820,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 3
>[2011/06/26 17:38:26.294849,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 2
>[2011/06/26 17:38:26.294873,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.294898,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (1003, 100) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.294959,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(1003, 100) : sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.294981,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(100) : conn_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.294997,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2011/06/26 17:38:26.295057,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (1003, 100) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:26.295141,  2] smbd/open.c:631(open_file)
>  michael opened file scanner.dat read=Yes write=Yes (numopen=1)
>[2011/06/26 17:38:26.295243,  2] smbd/dosmode.c:98(unix_mode)
>  unix_mode(scanner.dat) inheriting from .
>[2011/06/26 17:38:26.295265,  2] smbd/dosmode.c:121(unix_mode)
>  unix_mode(scanner.dat) inherit mode 40770
>[2011/06/26 17:38:26.295281,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(scanner.dat) returning 0760
>[2011/06/26 17:38:26.295932,  3] smbd/process.c:1485(process_smb)
>  Transaction 5 of length 74 (0 toread)
>[2011/06/26 17:38:26.295987,  3] smbd/process.c:1294(switch_message)
>  switch message SMBopenX (pid 1799) conn 0x7fa9ab8a0190
>[2011/06/26 17:38:26.296020,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/mnt/data1/eitelwein]
>[2011/06/26 17:38:26.296046,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /mnt/data1/eitelwein
>[2011/06/26 17:38:26.296065,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/mnt/data1/eitelwein]
>[2011/06/26 17:38:26.296082,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /mnt/data1/eitelwein
>[2011/06/26 17:38:26.296106,  2] smbd/dosmode.c:98(unix_mode)
>  unix_mode(.) inheriting from .
>[2011/06/26 17:38:26.296124,  2] smbd/dosmode.c:121(unix_mode)
>  unix_mode(.) inherit mode 40770
>[2011/06/26 17:38:26.296140,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0760
>[2011/06/26 17:38:26.296155,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/mnt/data1/eitelwein]
>[2011/06/26 17:38:26.296173,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /mnt/data1/eitelwein
>[2011/06/26 17:38:26.296276,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/error.c(160) cmd=45 (SMBopenX) NT_STATUS_FILE_IS_A_DIRECTORY
>[2011/06/26 17:38:26.296586,  3] smbd/process.c:1485(process_smb)
>  Transaction 6 of length 1106 (0 toread)
>[2011/06/26 17:38:26.296615,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 1799) conn 0x7fa9ab8a0190
>[2011/06/26 17:38:26.296681,  0] smbd/nttrans.c:2751(handle_nttrans)
>  handle_nttrans: Unknown request 0 in nttrans call
>[2011/06/26 17:38:26.297130,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(2752) cmd=160 (SMBnttrans) NT_STATUS_INVALID_LEVEL
>[2011/06/26 17:38:26.297433,  3] smbd/process.c:1485(process_smb)
>  Transaction 7 of length 1110 (0 toread)
>[2011/06/26 17:38:26.297466,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 1799) conn 0x7fa9ab8a0190
>[2011/06/26 17:38:26.297490,  0] smbd/nttrans.c:2751(handle_nttrans)
>  handle_nttrans: Unknown request 0 in nttrans call
>[2011/06/26 17:38:26.297836,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(2752) cmd=160 (SMBnttrans) NT_STATUS_INVALID_LEVEL
>[2011/06/26 17:38:26.297987,  3] smbd/process.c:1485(process_smb)
>  Transaction 8 of length 1110 (0 toread)
>[2011/06/26 17:38:26.298016,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 1799) conn 0x7fa9ab8a0190
>[2011/06/26 17:38:26.298037,  0] smbd/nttrans.c:2751(handle_nttrans)
>  handle_nttrans: Unknown request 0 in nttrans call
>[2011/06/26 17:38:26.298345,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(2752) cmd=160 (SMBnttrans) NT_STATUS_INVALID_LEVEL
>[2011/06/26 17:38:29.355061,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:29.355560,  2] smbd/close.c:656(close_normal_file)
>  michael closed file scanner.dat (numopen=0) NT_STATUS_OK
>[2011/06/26 17:38:29.355653,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:29.355810,  1] smbd/service.c:1251(close_cnum)
>  ubuntu-samba (192.168.123.192) closed connection to service eitelwein
>[2011/06/26 17:38:29.355856,  3] smbd/connection.c:31(yield_connection)
>  Yielding connection to eitelwein
>[2011/06/26 17:38:29.355969,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2011/06/26 17:38:29.366709,  3] smbd/connection.c:31(yield_connection)
>  Yielding connection to 
>[2011/06/26 17:38:29.367266,  3] smbd/server.c:906(exit_server_common)
>  Server exit (failed to receive smb request)

Actions: View

Attachments on bug 8251: 6602 | 6603 | 6627 | 6628 | 6629