Setting ACLs when creating files from Windows

Corinna Vinschen corinna at vinschen.de
Thu Jul 31 08:35:46 GMT 2008


On Jul 30 22:10, Volker Lendecke wrote:
> On Wed, Jul 30, 2008 at 07:26:48PM +0200, Corinna Vinschen wrote:
> > > Good question. We'd need a debug level 10 log of that.
> > 
> > To the list?  Or PM?
> 
> PM if you like.

List is fine.  A level 10 log is just a lot of stuff and I wasn't sure
everybody would like it.  The log of the complete operation is attached.

To explain what's going on, I reverted my Samba patch in Cygwin and
called `echo foo > xxx'.  What you see in the log is that Cygwin first
tries to find out if the file exists.  To accomplish transparent
handling of .exe and .lnk (shortcuts as symlinks) suffixes, Cygwin tests
first if "xxx" exists and, if not, if "xxx.exe", "xxx.lnk" or (for
historical reasons) "xxx.exe.lnk" exists.  Then Cygwin fetches file
system information. 

When creating the file, NtCreateFile is called with a security
descriptor containing a DACL with three ACEs, the current Windows user
(S-1-5-21-2913048732-1697188782-3448811101-1001), the user's primary
group (S-1-5-21-2913048732-1697188782-3448811101-1125) and Everyone
(S-1-1-0).

That's all.  Apparently Samba knows to switch to the local UNIX user
corinna from the incoming request and creates the file as that user.
But eventually, in the call tyo set_nt_acl, legacy_sid_to_uid doesn't
know about the user mapping anymore and fails.

> > Yes, that's the long term idea.  However, the SID<->uid/gid mapping
> > is still a problem.  With NFS, you can simply set the permission bits
> 
> Oooohhhh yes. ID mapping is the most controversial topic
> that the Samba Team fights to get right for more than 10
> years now, and even internally we completely disagree how
> this should work. But that's another thread :-)

:)


Thanks for your help,
Corinna
-------------- next part --------------
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 164
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0xa4
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 11 of length 168
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=164
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=704
  smt_wct=19
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=15872 (0x3E00)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]= 6144 (0x1800)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=25856 (0x6500)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=15872 (0x3E00)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=19456 (0x4C00)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]= 6144 (0x1800)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]=35840 (0x8C00)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=    0 (0x0)
  smb_vwv[18]=    1 (0x1)
  smb_bcc=91
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 10 00 00 00 00  00 00 00 88 00 02 00 00  ........ ........
  [010] 00 00 00 00 00 00 00 80  00 00 00 07 00 00 00 01  ........ ........
  [020] 00 00 00 00 00 20 00 00  00 00 00 18 00 00 00 08  ..... .. ........
  [030] 00 00 00 02 00 00 00 00  00 5C 00 78 00 78 00 78  ........ .\.x.x.x
  [040] 00 00 00 00 00 00 00 00  0C 00 00 4E 66 73 41 63  ........ ...NfsAc
  [050] 74 4F 6E 4C 69 6E 6B 00  00 00 00                 tOnLink. ...
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBnttrans (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 5] smbd/nttrans.c:call_nt_transact_create(1176)
  call_nt_transact_create
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file "xxx"
[2008/07/31 10:26:57, 10] smbd/statcache.c:stat_cache_lookup(215)
  stat_cache_lookup: lookup failed for name [XXX]
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(246)
  unix_convert begin: name = xxx, dirpath = , start = xxx
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(440)
  New file xxx
[2008/07/31 10:26:57, 10] smbd/trans2.c:read_ea_list_entry(489)
  read_ea_list_entry: read ea name NfsActOnLink
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(xxx) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=xxx, dos_attrs=0x80 access_mask=0x20088 share_access=0x7 create_disposition = 0x1 create_options=0x200000 unix mode=0644 oplock_request=0
[2008/07/31 10:26:57, 5] smbd/open.c:open_file_ntcreate(1264)
  open_file_ntcreate: FILE_OPEN requested for file xxx and file doesn't exist.
[2008/07/31 10:26:57, 3] smbd/error.c:error_packet_set(106)
  error packet at smbd/nttrans.c(1453) cmd=160 (SMBnttrans) NT_STATUS_OBJECT_NAME_NOT_FOUND
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0xa0
  smb_rcls=52
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=704
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 172
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0xac
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 12 of length 176
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=172
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=768
  smt_wct=19
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=17920 (0x4600)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]= 6144 (0x1800)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=25856 (0x6500)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=17920 (0x4600)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=19456 (0x4C00)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]= 6144 (0x1800)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]=37888 (0x9400)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=    0 (0x0)
  smb_vwv[18]=    1 (0x1)
  smb_bcc=99
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 10 00 00 00 00  00 00 00 88 00 02 00 00  ........ ........
  [010] 00 00 00 00 00 00 00 80  00 00 00 07 00 00 00 01  ........ ........
  [020] 00 00 00 00 00 20 00 00  00 00 00 18 00 00 00 10  ..... .. ........
  [030] 00 00 00 02 00 00 00 00  00 5C 00 78 00 78 00 78  ........ .\.x.x.x
  [040] 00 2E 00 65 00 78 00 65  00 00 00 00 00 00 00 00  ...e.x.e ........
  [050] 0C 00 00 4E 66 73 41 63  74 4F 6E 4C 69 6E 6B 00  ...NfsAc tOnLink.
  [060] 00 00 00                                          ... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBnttrans (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 5] smbd/nttrans.c:call_nt_transact_create(1176)
  call_nt_transact_create
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file "xxx.exe"
[2008/07/31 10:26:57, 10] smbd/statcache.c:stat_cache_lookup(215)
  stat_cache_lookup: lookup failed for name [XXX.EXE]
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(246)
  unix_convert begin: name = xxx.exe, dirpath = , start = xxx.exe
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.exe ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.exe (len 7) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.exe ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.exe (len 7) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.exe ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.exe (len 7) ?
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(440)
  New file xxx.exe
[2008/07/31 10:26:57, 10] smbd/trans2.c:read_ea_list_entry(489)
  read_ea_list_entry: read ea name NfsActOnLink
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(xxx.exe) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=xxx.exe, dos_attrs=0x80 access_mask=0x20088 share_access=0x7 create_disposition = 0x1 create_options=0x200000 unix mode=0644 oplock_request=0
[2008/07/31 10:26:57, 5] smbd/open.c:open_file_ntcreate(1264)
  open_file_ntcreate: FILE_OPEN requested for file xxx.exe and file doesn't exist.
[2008/07/31 10:26:57, 3] smbd/error.c:error_packet_set(106)
  error packet at smbd/nttrans.c(1453) cmd=160 (SMBnttrans) NT_STATUS_OBJECT_NAME_NOT_FOUND
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0xa0
  smb_rcls=52
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=768
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 172
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0xac
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 13 of length 176
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=172
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=832
  smt_wct=19
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=17920 (0x4600)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]= 6144 (0x1800)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=25856 (0x6500)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=17920 (0x4600)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=19456 (0x4C00)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]= 6144 (0x1800)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]=37888 (0x9400)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=    0 (0x0)
  smb_vwv[18]=    1 (0x1)
  smb_bcc=99
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 10 00 00 00 00  00 00 00 88 00 02 00 00  ........ ........
  [010] 00 00 00 00 00 00 00 80  00 00 00 07 00 00 00 01  ........ ........
  [020] 00 00 00 00 00 20 00 00  00 00 00 18 00 00 00 10  ..... .. ........
  [030] 00 00 00 02 00 00 00 00  00 5C 00 78 00 78 00 78  ........ .\.x.x.x
  [040] 00 2E 00 6C 00 6E 00 6B  00 00 00 00 00 00 00 00  ...l.n.k ........
  [050] 0C 00 00 4E 66 73 41 63  74 4F 6E 4C 69 6E 6B 00  ...NfsAc tOnLink.
  [060] 00 00 00                                          ... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBnttrans (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 5] smbd/nttrans.c:call_nt_transact_create(1176)
  call_nt_transact_create
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file "xxx.lnk"
[2008/07/31 10:26:57, 10] smbd/statcache.c:stat_cache_lookup(215)
  stat_cache_lookup: lookup failed for name [XXX.LNK]
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(246)
  unix_convert begin: name = xxx.lnk, dirpath = , start = xxx.lnk
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.lnk ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.lnk (len 7) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.lnk ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.lnk (len 7) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.lnk ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.lnk (len 7) ?
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(440)
  New file xxx.lnk
[2008/07/31 10:26:57, 10] smbd/trans2.c:read_ea_list_entry(489)
  read_ea_list_entry: read ea name NfsActOnLink
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(xxx.lnk) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=xxx.lnk, dos_attrs=0x80 access_mask=0x20088 share_access=0x7 create_disposition = 0x1 create_options=0x200000 unix mode=0644 oplock_request=0
[2008/07/31 10:26:57, 5] smbd/open.c:open_file_ntcreate(1264)
  open_file_ntcreate: FILE_OPEN requested for file xxx.lnk and file doesn't exist.
[2008/07/31 10:26:57, 3] smbd/error.c:error_packet_set(106)
  error packet at smbd/nttrans.c(1453) cmd=160 (SMBnttrans) NT_STATUS_OBJECT_NAME_NOT_FOUND
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0xa0
  smb_rcls=52
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=832
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 180
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0xb4
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 14 of length 184
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=180
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=896
  smt_wct=19
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=19968 (0x4E00)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]= 6144 (0x1800)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=25856 (0x6500)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=19968 (0x4E00)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=19456 (0x4C00)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]= 6144 (0x1800)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]=39936 (0x9C00)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=    0 (0x0)
  smb_vwv[18]=    1 (0x1)
  smb_bcc=107
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 10 00 00 00 00  00 00 00 88 00 02 00 00  ........ ........
  [010] 00 00 00 00 00 00 00 80  00 00 00 07 00 00 00 01  ........ ........
  [020] 00 00 00 00 00 20 00 00  00 00 00 18 00 00 00 18  ..... .. ........
  [030] 00 00 00 02 00 00 00 00  00 5C 00 78 00 78 00 78  ........ .\.x.x.x
  [040] 00 2E 00 65 00 78 00 65  00 2E 00 6C 00 6E 00 6B  ...e.x.e ...l.n.k
  [050] 00 00 00 00 00 00 00 00  0C 00 00 4E 66 73 41 63  ........ ...NfsAc
  [060] 74 4F 6E 4C 69 6E 6B 00  00 00 00                 tOnLink. ...
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBnttrans (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 5] smbd/nttrans.c:call_nt_transact_create(1176)
  call_nt_transact_create
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file "xxx.exe.lnk"
[2008/07/31 10:26:57, 10] smbd/statcache.c:stat_cache_lookup(215)
  stat_cache_lookup: lookup failed for name [XXX.EXE.LNK]
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(246)
  unix_convert begin: name = xxx.exe.lnk, dirpath = , start = xxx.exe.lnk
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.exe.lnk ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.exe.lnk (len 11) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.exe.lnk ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.exe.lnk (len 11) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx.exe.lnk ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx.exe.lnk (len 11) ?
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(440)
  New file xxx.exe.lnk
[2008/07/31 10:26:57, 10] smbd/trans2.c:read_ea_list_entry(489)
  read_ea_list_entry: read ea name NfsActOnLink
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(xxx.exe.lnk) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=xxx.exe.lnk, dos_attrs=0x80 access_mask=0x20088 share_access=0x7 create_disposition = 0x1 create_options=0x200000 unix mode=0644 oplock_request=0
[2008/07/31 10:26:57, 5] smbd/open.c:open_file_ntcreate(1264)
  open_file_ntcreate: FILE_OPEN requested for file xxx.exe.lnk and file doesn't exist.
[2008/07/31 10:26:57, 3] smbd/error.c:error_packet_set(106)
  error packet at smbd/nttrans.c(1453) cmd=160 (SMBnttrans) NT_STATUS_OBJECT_NAME_NOT_FOUND
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0xa0
  smb_rcls=52
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=896
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 156
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x9c
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 15 of length 160
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=156
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=960
  smt_wct=19
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=13824 (0x3600)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]= 6144 (0x1800)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=25856 (0x6500)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=13824 (0x3600)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=19456 (0x4C00)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]= 6144 (0x1800)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]=33792 (0x8400)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=    0 (0x0)
  smb_vwv[18]=    1 (0x1)
  smb_bcc=83
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 10 00 00 00 00  00 00 00 88 00 02 00 00  ........ ........
  [010] 00 00 00 00 00 00 00 80  00 00 00 07 00 00 00 01  ........ ........
  [020] 00 00 00 00 00 20 00 00  00 00 00 18 00 00 00 00  ..... .. ........
  [030] 00 00 00 02 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [040] 0C 00 00 4E 66 73 41 63  74 4F 6E 4C 69 6E 6B 00  ...NfsAc tOnLink.
  [050] 00 00 00                                          ... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBnttrans (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 5] smbd/nttrans.c:call_nt_transact_create(1176)
  call_nt_transact_create
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file ""
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(176)
  conversion finished "" -> .
[2008/07/31 10:26:57, 10] smbd/trans2.c:read_ea_list_entry(489)
  read_ea_list_entry: read ea name NfsActOnLink
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(.) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=., dos_attrs=0x80 access_mask=0x20088 share_access=0x7 create_disposition = 0x1 create_options=0x200000 unix mode=0644 oplock_request=0
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1347)
  open_file_ntcreate: fname=., after mapping access_mask=0x20088
[2008/07/31 10:26:57, 5] smbd/files.c:file_new(123)
  allocated file structure 3656, fnum = 7752 (1 used)
[2008/07/31 10:26:57, 4] smbd/open.c:open_file_ntcreate(1605)
  calling open_file with flags=0x0 flags2=0x0 mode=0644, access_mask = 0x20088, open_access_mask = 0x20088
[2008/07/31 10:26:57, 5] smbd/files.c:file_free(454)
  freed files structure 7752 (0 used)
[2008/07/31 10:26:57, 5] smbd/open.c:open_directory(2057)
  open_directory: opening directory ., access_mask = 0x20088, share_access = 0x7 create_options = 0x200000, create_disposition = 0x1, file_attributes = 0x80
[2008/07/31 10:26:57, 5] smbd/files.c:file_new(123)
  allocated file structure 3657, fnum = 7753 (1 used)
[2008/07/31 10:26:57, 10] locking/locking.c:unparse_share_modes(681)
  unparse_share_modes: del: 0, tok = 0, num: 1
[2008/07/31 10:26:57, 10] locking/locking.c:print_share_mode_table(498)
  print_share_mode_table: share_mode_entry[0]:  pid = 23345, share_access = 0x7, private_options = 0x200000, access_mask = 0x20088, mid = 0x0, type= 0x0, file_id = 4, uid = 500, flags = 2, dev = 0x803, inode = 6799362
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:57, 5] smbd/nttrans.c:call_nt_transact_create(1618)
  call_nt_transact_create: open name = .
[2008/07/31 10:26:57, 9] smbd/nttrans.c:send_nt_replies(230)
  nt_rep: params_sent_thistime = 101, data_sent_thistime = 0, useable_space = 130994
[2008/07/31 10:26:57, 9] smbd/nttrans.c:send_nt_replies(232)
  nt_rep: params_to_send = 101, data_to_send = 0, paramsize = 101, datasize = 0
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=175
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=960
  smt_wct=18
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=25856 (0x6500)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    0 (0x0)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=25856 (0x6500)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=18944 (0x4A00)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    0 (0x0)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]=    0 (0x0)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=    0 (0x0)
  smb_bcc=104
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 49 1E 01  00 00 00 00 00 00 00 80  .....I.. ........
  [010] EA 36 2D E7 F2 C8 01 80  9E FB 31 E7 F2 C8 01 80  .6-..... ..1.....
  [020] EA 36 2D E7 F2 C8 01 80  EA 36 2D E7 F2 C8 01 10  .6-..... .6-.....
  [030] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [040] 00 00 00 00 00 07 00 01  00 00 00 00 00 00 00 00  ........ ........
  [050] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [060] FF 01 1F 00 00 00 00 00                           ........ 
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 72
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x48
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 16 of length 76
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=72
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1024
  smt_wct=15
  smb_vwv[ 0]=    4 (0x4)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    2 (0x2)
  smb_vwv[ 3]=   40 (0x28)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    4 (0x4)
  smb_vwv[10]=   68 (0x44)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    1 (0x1)
  smb_vwv[14]=    7 (0x7)
  smb_bcc=7
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 49 1E EC 03                              ...I... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfilepathinfo(3244)
  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1004
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfilepathinfo(3355)
  call_trans2qfilepathinfo . (fnum = 7753) level=1004 call=7 total_data=0
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:57, 10] smbd/trans2.c:call_trans2qfilepathinfo(3590)
  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
[2008/07/31 10:26:57, 5] smbd/trans2.c:call_trans2qfilepathinfo(3600)
  SMB_QFBI - create: Thu Jul 31 10:26:49 2008
   access: Thu Jul 31 10:26:57 2008
   write: Thu Jul 31 10:26:49 2008
   change: Thu Jul 31 10:26:49 2008
   mode: 10
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(712)
  t2_rep: params_sent_thistime = 2, data_sent_thistime = 40, useable_space = 131010
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(714)
  t2_rep: params_to_send = 2, data_to_send = 40, paramsize = 2, datasize = 40
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=100
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1024
  smt_wct=10
  smb_vwv[ 0]=    2 (0x2)
  smb_vwv[ 1]=   40 (0x28)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    2 (0x2)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=   40 (0x28)
  smb_vwv[ 7]=   60 (0x3C)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=45
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 80 EA 36  2D E7 F2 C8 01 80 9E FB  .......6 -.......
  [010] 31 E7 F2 C8 01 80 EA 36  2D E7 F2 C8 01 80 EA 36  1......6 -......6
  [020] 2D E7 F2 C8 01 10 00 00  00 00 00 00 00           -....... .....
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 70
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x46
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 17 of length 74
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=70
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1088
  smt_wct=15
  smb_vwv[ 0]=    2 (0x2)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  560 (0x230)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    2 (0x2)
  smb_vwv[10]=   68 (0x44)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    1 (0x1)
  smb_vwv[14]=    3 (0x3)
  smb_bcc=5
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 05 01                                    ..... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfsinfo(2285)
  call_trans2qfsinfo: level = 261
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(712)
  t2_rep: params_sent_thistime = 0, data_sent_thistime = 20, useable_space = 131012
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(714)
  t2_rep: params_to_send = 0, data_to_send = 20, paramsize = 0, datasize = 20
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=76
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1088
  smt_wct=10
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=   20 (0x14)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    0 (0x0)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=   20 (0x14)
  smb_vwv[ 7]=   56 (0x38)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=21
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 2F 00 00 00 FF 00 00  00 08 00 00 00 4E 00 54  ./...... .....N.T
  [010] 00 46 00 53 00                                    .F.S. 
[2008/07/31 10:26:57, 4] smbd/trans2.c:call_trans2qfsinfo(2745)
  SMBtrans2 info_level = 261
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 70
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x46
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 18 of length 74
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=70
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1152
  smt_wct=15
  smb_vwv[ 0]=    2 (0x2)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  560 (0x230)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    2 (0x2)
  smb_vwv[10]=   68 (0x44)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    1 (0x1)
  smb_vwv[14]=    3 (0x3)
  smb_bcc=5
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 F0 03                                    ..... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfsinfo(2285)
  call_trans2qfsinfo: level = 1008
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(712)
  t2_rep: params_sent_thistime = 0, data_sent_thistime = 64, useable_space = 131012
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(714)
  t2_rep: params_to_send = 0, data_to_send = 64, paramsize = 0, datasize = 64
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=120
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1152
  smt_wct=10
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=   64 (0x40)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    0 (0x0)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=   64 (0x40)
  smb_vwv[ 7]=   56 (0x38)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=65
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [010] 00 61 42 6D 53 00 1E 00  03 00 00 00 00 08 00 00  .aBmS... ........
  [020] 00 30 00 00 00 33 2E 30  2E 33 30 00              .0...3.0 .30.
[2008/07/31 10:26:57, 4] smbd/trans2.c:call_trans2qfsinfo(2745)
  SMBtrans2 info_level = 1008
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 41
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x29
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 19 of length 45
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=41
  smb_com=0x4
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=65279
  smb_uid=101
  smb_mid=1216
  smt_wct=3
  smb_vwv[ 0]= 7753 (0x1E49)
  smb_vwv[ 1]=65535 (0xFFFF)
  smb_vwv[ 2]=65535 (0xFFFF)
  smb_bcc=0
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBclose (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/reply.c:reply_close(3329)
  close directory fnum=7753
[2008/07/31 10:26:57, 10] locking/locking.c:parse_share_modes(523)
  parse_share_modes: delete_on_close: 0, num_share_modes: 1
[2008/07/31 10:26:57, 10] locking/locking.c:parse_share_modes(623)
  parse_share_modes: share_mode_entry[0]:  pid = 23345, share_access = 0x7, private_options = 0x200000, access_mask = 0x20088, mid = 0x0, type= 0x0, file_id = 4, uid = 500, flags = 2, dev = 0x803, inode = 6799362
[2008/07/31 10:26:57, 5] smbd/files.c:file_free(454)
  freed files structure 7753 (0 used)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0x4
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51201
  smb_tid=2
  smb_pid=65279
  smb_uid=101
  smb_mid=1216
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 94
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x5e
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 20 of length 98
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=94
  smb_com=0xa2
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1280
  smt_wct=24
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=57054 (0xDEDE)
  smb_vwv[ 2]= 2048 (0x800)
  smb_vwv[ 3]= 4096 (0x1000)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=  512 (0x200)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    0 (0x0)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]= 1792 (0x700)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=  256 (0x100)
  smb_vwv[18]=    0 (0x0)
  smb_vwv[19]=    0 (0x0)
  smb_vwv[20]=    0 (0x0)
  smb_vwv[21]=  512 (0x200)
  smb_vwv[22]=    0 (0x0)
  smb_vwv[23]=    0 (0x0)
  smb_bcc=11
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] FF 5C 00 78 00 78 00 78  00 00 00                 .\.x.x.x ...
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBntcreateX (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 10] smbd/nttrans.c:reply_ntcreate_and_X(515)
  reply_ntcreate_and_X: flags = 0x10, access_mask = 0x20000 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x0 root_dir_fid = 0x0
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file "xxx"
[2008/07/31 10:26:57, 10] smbd/statcache.c:stat_cache_lookup(215)
  stat_cache_lookup: lookup failed for name [XXX]
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(246)
  unix_convert begin: name = xxx, dirpath = , start = xxx
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(440)
  New file xxx
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(xxx) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=xxx, dos_attrs=0x0 access_mask=0x20000 share_access=0x7 create_disposition = 0x1 create_options=0x0 unix mode=0644 oplock_request=0
[2008/07/31 10:26:57, 5] smbd/open.c:open_file_ntcreate(1264)
  open_file_ntcreate: FILE_OPEN requested for file xxx and file doesn't exist.
[2008/07/31 10:26:57, 3] smbd/error.c:error_packet_set(106)
  error packet at smbd/nttrans.c(805) cmd=162 (SMBntcreateX) NT_STATUS_OBJECT_NAME_NOT_FOUND
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0xa2
  smb_rcls=52
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51201
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1280
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 86
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x56
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 21 of length 90
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=86
  smb_com=0xa2
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1344
  smt_wct=24
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=57054 (0xDEDE)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]= 4096 (0x1000)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=  512 (0x200)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    0 (0x0)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]= 1792 (0x700)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=  256 (0x100)
  smb_vwv[18]=    0 (0x0)
  smb_vwv[19]=    0 (0x0)
  smb_vwv[20]=    0 (0x0)
  smb_vwv[21]=  512 (0x200)
  smb_vwv[22]=    0 (0x0)
  smb_vwv[23]=    0 (0x0)
  smb_bcc=3
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00                                          ... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBntcreateX (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 10] smbd/nttrans.c:reply_ntcreate_and_X(515)
  reply_ntcreate_and_X: flags = 0x10, access_mask = 0x20000 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x0 root_dir_fid = 0x0
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file ""
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(176)
  conversion finished "" -> .
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(.) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=., dos_attrs=0x0 access_mask=0x20000 share_access=0x7 create_disposition = 0x1 create_options=0x0 unix mode=0644 oplock_request=0
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1347)
  open_file_ntcreate: fname=., after mapping access_mask=0x20000
[2008/07/31 10:26:57, 5] smbd/files.c:file_new(123)
  allocated file structure 3658, fnum = 7754 (1 used)
[2008/07/31 10:26:57, 4] smbd/open.c:open_file_ntcreate(1605)
  calling open_file with flags=0x0 flags2=0x0 mode=0644, access_mask = 0x20000, open_access_mask = 0x20000
[2008/07/31 10:26:57, 5] smbd/files.c:file_free(454)
  freed files structure 7754 (0 used)
[2008/07/31 10:26:57, 5] smbd/open.c:open_directory(2057)
  open_directory: opening directory ., access_mask = 0x20000, share_access = 0x7 create_options = 0x0, create_disposition = 0x1, file_attributes = 0x0
[2008/07/31 10:26:57, 5] smbd/files.c:file_new(123)
  allocated file structure 3659, fnum = 7755 (1 used)
[2008/07/31 10:26:57, 10] locking/locking.c:unparse_share_modes(681)
  unparse_share_modes: del: 0, tok = 0, num: 1
[2008/07/31 10:26:57, 10] locking/locking.c:print_share_mode_table(498)
  print_share_mode_table: share_mode_entry[0]:  pid = 23345, share_access = 0x7, private_options = 0x0, access_mask = 0x20000, mid = 0x0, type= 0x0, file_id = 6, uid = 500, flags = 2, dev = 0x803, inode = 6799362
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:57, 5] smbd/nttrans.c:reply_ntcreate_and_X(940)
  reply_ntcreate_and_X: fnum = 7755, open name = .
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=135
  smb_com=0xa2
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51201
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1344
  smt_wct=42
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=19200 (0x4B00)
  smb_vwv[ 3]=  286 (0x11E)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=32768 (0x8000)
  smb_vwv[ 6]=14058 (0x36EA)
  smb_vwv[ 7]=59181 (0xE72D)
  smb_vwv[ 8]=51442 (0xC8F2)
  smb_vwv[ 9]=32769 (0x8001)
  smb_vwv[10]=64414 (0xFB9E)
  smb_vwv[11]=59185 (0xE731)
  smb_vwv[12]=51442 (0xC8F2)
  smb_vwv[13]=32769 (0x8001)
  smb_vwv[14]=14058 (0x36EA)
  smb_vwv[15]=59181 (0xE72D)
  smb_vwv[16]=51442 (0xC8F2)
  smb_vwv[17]=32769 (0x8001)
  smb_vwv[18]=14058 (0x36EA)
  smb_vwv[19]=59181 (0xE72D)
  smb_vwv[20]=51442 (0xC8F2)
  smb_vwv[21]= 4097 (0x1001)
  smb_vwv[22]=    0 (0x0)
  smb_vwv[23]=    0 (0x0)
  smb_vwv[24]=    0 (0x0)
  smb_vwv[25]=    0 (0x0)
  smb_vwv[26]=    0 (0x0)
  smb_vwv[27]=    0 (0x0)
  smb_vwv[28]=    0 (0x0)
  smb_vwv[29]=    0 (0x0)
  smb_vwv[30]=    0 (0x0)
  smb_vwv[31]=    0 (0x0)
  smb_vwv[32]= 1792 (0x700)
  smb_vwv[33]=  256 (0x100)
  smb_vwv[34]=    0 (0x0)
  smb_vwv[35]=    0 (0x0)
  smb_vwv[36]=    0 (0x0)
  smb_vwv[37]=    0 (0x0)
  smb_vwv[38]=    0 (0x0)
  smb_vwv[39]=    0 (0x0)
  smb_vwv[40]=    0 (0x0)
  smb_vwv[41]=    0 (0x0)
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 72
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x48
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 22 of length 76
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=72
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1408
  smt_wct=15
  smb_vwv[ 0]=    4 (0x4)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    2 (0x2)
  smb_vwv[ 3]=    8 (0x8)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    4 (0x4)
  smb_vwv[10]=   68 (0x44)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    1 (0x1)
  smb_vwv[14]=    7 (0x7)
  smb_bcc=7
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 4B 1E EE 03                              ...K... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfilepathinfo(3244)
  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1006
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfilepathinfo(3355)
  call_trans2qfilepathinfo . (fnum = 7755) level=1006 call=7 total_data=0
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:57, 10] smbd/trans2.c:call_trans2qfilepathinfo(3707)
  call_trans2qfilepathinfo: SMB_FILE_INTERNAL_INFORMATION
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(712)
  t2_rep: params_sent_thistime = 2, data_sent_thistime = 8, useable_space = 131010
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(714)
  t2_rep: params_to_send = 2, data_to_send = 8, paramsize = 2, datasize = 8
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=68
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1408
  smt_wct=10
  smb_vwv[ 0]=    2 (0x2)
  smb_vwv[ 1]=    8 (0x8)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    2 (0x2)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    8 (0x8)
  smb_vwv[ 7]=   60 (0x3C)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=13
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 02 C0 67  00 03 08 00 00           .......g .....
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 70
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x46
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 23 of length 74
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=70
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1472
  smt_wct=15
  smb_vwv[ 0]=    2 (0x2)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  560 (0x230)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    2 (0x2)
  smb_vwv[10]=   68 (0x44)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    1 (0x1)
  smb_vwv[14]=    3 (0x3)
  smb_bcc=5
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 05 01                                    ..... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfsinfo(2285)
  call_trans2qfsinfo: level = 261
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(712)
  t2_rep: params_sent_thistime = 0, data_sent_thistime = 20, useable_space = 131012
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(714)
  t2_rep: params_to_send = 0, data_to_send = 20, paramsize = 0, datasize = 20
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=76
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1472
  smt_wct=10
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=   20 (0x14)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    0 (0x0)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=   20 (0x14)
  smb_vwv[ 7]=   56 (0x38)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=21
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 2F 00 00 00 FF 00 00  00 08 00 00 00 4E 00 54  ./...... .....N.T
  [010] 00 46 00 53 00                                    .F.S. 
[2008/07/31 10:26:57, 4] smbd/trans2.c:call_trans2qfsinfo(2745)
  SMBtrans2 info_level = 261
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 70
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x46
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 24 of length 74
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=70
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1536
  smt_wct=15
  smb_vwv[ 0]=    2 (0x2)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  560 (0x230)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    2 (0x2)
  smb_vwv[10]=   68 (0x44)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=    1 (0x1)
  smb_vwv[14]=    3 (0x3)
  smb_bcc=5
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 F0 03                                    ..... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/trans2.c:call_trans2qfsinfo(2285)
  call_trans2qfsinfo: level = 1008
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(712)
  t2_rep: params_sent_thistime = 0, data_sent_thistime = 64, useable_space = 131012
[2008/07/31 10:26:57, 9] smbd/trans2.c:send_trans2_replies(714)
  t2_rep: params_to_send = 0, data_to_send = 64, paramsize = 0, datasize = 64
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=120
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1536
  smt_wct=10
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=   64 (0x40)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    0 (0x0)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=   64 (0x40)
  smb_vwv[ 7]=   56 (0x38)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=65
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [010] 00 61 42 6D 53 00 1E 00  03 00 00 00 00 08 00 00  .aBmS... ........
  [020] 00 30 00 00 00 33 2E 30  2E 33 30 00              .0...3.0 .30.
[2008/07/31 10:26:57, 4] smbd/trans2.c:call_trans2qfsinfo(2745)
  SMBtrans2 info_level = 1008
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 41
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x29
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 25 of length 45
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=41
  smb_com=0x4
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=65279
  smb_uid=101
  smb_mid=1600
  smt_wct=3
  smb_vwv[ 0]= 7755 (0x1E4B)
  smb_vwv[ 1]=65535 (0xFFFF)
  smb_vwv[ 2]=65535 (0xFFFF)
  smb_bcc=0
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBclose (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 3] smbd/reply.c:reply_close(3329)
  close directory fnum=7755
[2008/07/31 10:26:57, 10] locking/locking.c:parse_share_modes(523)
  parse_share_modes: delete_on_close: 0, num_share_modes: 1
[2008/07/31 10:26:57, 10] locking/locking.c:parse_share_modes(623)
  parse_share_modes: share_mode_entry[0]:  pid = 23345, share_access = 0x7, private_options = 0x0, access_mask = 0x20000, mid = 0x0, type= 0x0, file_id = 6, uid = 500, flags = 2, dev = 0x803, inode = 6799362
[2008/07/31 10:26:57, 5] smbd/files.c:file_free(454)
  freed files structure 7755 (0 used)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0x4
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51201
  smb_tid=2
  smb_pid=65279
  smb_uid=101
  smb_mid=1600
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:57, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 316
[2008/07/31 10:26:57, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x13c
[2008/07/31 10:26:57, 3] smbd/process.c:process_smb(1069)
  Transaction 26 of length 320
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=316
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1664
  smt_wct=19
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=15872 (0x3E00)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=45056 (0xB000)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=25856 (0x6500)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=    0 (0x0)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=15872 (0x3E00)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=19456 (0x4C00)
  smb_vwv[12]=    0 (0x0)
  smb_vwv[13]=45056 (0xB000)
  smb_vwv[14]=    0 (0x0)
  smb_vwv[15]=35840 (0x8C00)
  smb_vwv[16]=    0 (0x0)
  smb_vwv[17]=    0 (0x0)
  smb_vwv[18]=    1 (0x1)
  smb_bcc=243
[2008/07/31 10:26:57, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 16 00 00 00 00  00 00 00 96 01 12 00 00  ........ ........
  [010] 00 00 00 00 00 00 00 80  00 00 00 07 00 00 00 05  ........ ........
  [020] 00 00 00 00 00 00 00 B0  00 00 00 00 00 00 00 08  ........ ........
  [030] 00 00 00 02 00 00 00 00  00 5C 00 78 00 78 00 78  ........ .\.x.x.x
  [040] 00 00 00 01 00 04 90 78  00 00 00 94 00 00 00 00  .......x ........
  [050] 00 00 00 14 00 00 00 02  00 64 00 03 00 00 00 00  ........ .d......
  [060] 00 24 00 9F 01 1F 00 01  05 00 00 00 00 00 05 15  .$...... ........
  [070] 00 00 00 9C 98 A1 AD AE  0B 29 65 5D AE 90 CD E9  ........ .)e]....
  [080] 03 00 00 00 00 24 00 89  00 12 00 01 05 00 00 00  .....$.. ........
  [090] 00 00 05 15 00 00 00 9C  98 A1 AD AE 0B 29 65 5D  ........ .....)e]
  [0A0] AE 90 CD 65 04 00 00 00  00 14 00 89 00 12 00 01  ...e.... ........
  [0B0] 01 00 00 00 00 00 01 00  00 00 00 01 05 00 00 00  ........ ........
  [0C0] 00 00 05 15 00 00 00 9C  98 A1 AD AE 0B 29 65 5D  ........ .....)e]
  [0D0] AE 90 CD E9 03 00 00 01  05 00 00 00 00 00 05 15  ........ ........
  [0E0] 00 00 00 9C 98 A1 AD AE  0B 29 65 5D AE 90 CD 65  ........ .)e]...e
  [0F0] 04 00 00                                          ... 
[2008/07/31 10:26:57, 3] smbd/process.c:switch_message(927)
  switch message SMBnttrans (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:57, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:57, 5] smbd/nttrans.c:call_nt_transact_create(1176)
  call_nt_transact_create
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file "xxx"
[2008/07/31 10:26:57, 10] smbd/statcache.c:stat_cache_lookup(215)
  stat_cache_lookup: lookup failed for name [XXX]
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(246)
  unix_convert begin: name = xxx, dirpath = , start = xxx
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled(276)
  is_mangled xxx ?
[2008/07/31 10:26:57, 10] smbd/mangle_hash2.c:is_mangled_component(215)
  is_mangled_component xxx (len 3) ?
[2008/07/31 10:26:57, 5] smbd/filename.c:unix_convert(440)
  New file xxx
[2008/07/31 10:26:57, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(xxx) returning 0644
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1184)
  open_file_ntcreate: fname=xxx, dos_attrs=0x80 access_mask=0x120196 share_access=0x7 create_disposition = 0x5 create_options=0x0 unix mode=0644 oplock_request=3
[2008/07/31 10:26:57, 10] smbd/open.c:open_file_ntcreate(1347)
  open_file_ntcreate: fname=xxx, after mapping access_mask=0x120196
[2008/07/31 10:26:57, 5] smbd/files.c:file_new(123)
  allocated file structure 3660, fnum = 7756 (1 used)
[2008/07/31 10:26:57, 4] smbd/open.c:open_file_ntcreate(1605)
  calling open_file with flags=0x2 flags2=0x240 mode=0644, access_mask = 0x120196, open_access_mask = 0x120196
[2008/07/31 10:26:57, 10] smbd/open.c:fd_open(67)
  fd_open: name xxx, flags = 0102 mode = 0644, fd = 27. 
[2008/07/31 10:26:57, 10] smbd/notify_internal.c:notify_trigger(589)
  notify_trigger called action=0x1, filter=0x1, path=/home/corinna/xxx
[2008/07/31 10:26:57, 2] smbd/open.c:open_file(391)
  corinna opened file xxx read=No write=Yes (numopen=1)
[2008/07/31 10:26:57, 3] smbd/oplock_linux.c:linux_set_kernel_oplock(180)
  linux_set_kernel_oplock: got kernel oplock on file xxx, dev = 803, inode = 6801475, file_id = 7
[2008/07/31 10:26:57, 5] smbd/oplock.c:set_file_oplock(126)
  set_file_oplock: granted oplock on file xxx, 0x803/6801475/7, tv_sec = 48917751, tv_usec = e86b7
[2008/07/31 10:26:57, 10] smbd/dosmode.c:file_set_dosmode(440)
  file_set_dosmode: setting dos mode 0x20 on file xxx
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: xxx
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning 
[2008/07/31 10:26:57, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning 
[2008/07/31 10:26:57, 10] smbd/dosmode.c:set_ea_dos_attribute(308)
  set_ea_dos_attribute: set EA 0x20 on file xxx
[2008/07/31 10:26:57, 10] locking/locking.c:unparse_share_modes(681)
  unparse_share_modes: del: 0, tok = 0, num: 1
[2008/07/31 10:26:57, 10] locking/locking.c:print_share_mode_table(498)
  print_share_mode_table: share_mode_entry[0]:  pid = 23345, share_access = 0x7, private_options = 0x0, access_mask = 0x120196, mid = 0x0, type= 0x3, file_id = 7, uid = 500, flags = 2, dev = 0x803, inode = 6801475
[2008/07/31 10:26:57, 6] rpc_parse/parse_prs.c:prs_debug(84)
      000000 sec_io_desc sd data
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint16(681)
          0000 revision : 0001
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint16(681)
          0002 type     : 9004
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
          0004 off_owner_sid: 00000078
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
          0008 off_grp_sid  : 00000094
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
          000c off_sacl     : 00000000
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
          0010 off_dacl     : 00000014
[2008/07/31 10:26:57, 7] rpc_parse/parse_prs.c:prs_debug(84)
          000078 smb_io_dom_sid owner_sid 
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0078 sid_rev_num: 01
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0079 num_auths  : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              007a id_auth[0] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              007b id_auth[1] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              007c id_auth[2] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              007d id_auth[3] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              007e id_auth[4] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              007f id_auth[5] : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32s(997)
              0080 sub_auths : 00000015 ada1989c 65290bae cd90ae5d 000003e9 
[2008/07/31 10:26:57, 7] rpc_parse/parse_prs.c:prs_debug(84)
          000094 smb_io_dom_sid group_sid
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0094 sid_rev_num: 01
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0095 num_auths  : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0096 id_auth[0] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0097 id_auth[1] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0098 id_auth[2] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              0099 id_auth[3] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              009a id_auth[4] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
              009b id_auth[5] : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32s(997)
              009c sub_auths : 00000015 ada1989c 65290bae cd90ae5d 00000465 
[2008/07/31 10:26:57, 7] rpc_parse/parse_prs.c:prs_debug(84)
          000014 sec_io_acl dacl
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint16(681)
              0014 revision: 0002
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint16(681)
              0016 size     : 0064
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
              0018 num_aces : 00000003
[2008/07/31 10:26:57, 8] rpc_parse/parse_prs.c:prs_debug(84)
              00001c sec_io_ace ace_list[00]: 
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                  001c type : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                  001d flags: 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint16(681)
                  001e size : 0024
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
                  0020 access_mask: 001f019f
[2008/07/31 10:26:57, 9] rpc_parse/parse_prs.c:prs_debug(84)
                  000024 smb_io_dom_sid trustee  
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0024 sid_rev_num: 01
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0025 num_auths  : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0026 id_auth[0] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0027 id_auth[1] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0028 id_auth[2] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0029 id_auth[3] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      002a id_auth[4] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      002b id_auth[5] : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32s(997)
                      002c sub_auths : 00000015 ada1989c 65290bae cd90ae5d 000003e9 
[2008/07/31 10:26:57, 8] rpc_parse/parse_prs.c:prs_debug(84)
              000040 sec_io_ace ace_list[01]: 
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                  0040 type : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                  0041 flags: 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint16(681)
                  0042 size : 0024
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
                  0044 access_mask: 00120089
[2008/07/31 10:26:57, 9] rpc_parse/parse_prs.c:prs_debug(84)
                  000048 smb_io_dom_sid trustee  
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0048 sid_rev_num: 01
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0049 num_auths  : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      004a id_auth[0] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      004b id_auth[1] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      004c id_auth[2] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      004d id_auth[3] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      004e id_auth[4] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      004f id_auth[5] : 05
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32s(997)
                      0050 sub_auths : 00000015 ada1989c 65290bae cd90ae5d 00000465 
[2008/07/31 10:26:57, 8] rpc_parse/parse_prs.c:prs_debug(84)
              000064 sec_io_ace ace_list[02]: 
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                  0064 type : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                  0065 flags: 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint16(681)
                  0066 size : 0014
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32(710)
                  0068 access_mask: 00120089
[2008/07/31 10:26:57, 9] rpc_parse/parse_prs.c:prs_debug(84)
                  00006c smb_io_dom_sid trustee  
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      006c sid_rev_num: 01
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      006d num_auths  : 01
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      006e id_auth[0] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      006f id_auth[1] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0070 id_auth[2] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0071 id_auth[3] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0072 id_auth[4] : 00
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint8(616)
                      0073 id_auth[5] : 01
[2008/07/31 10:26:57, 5] rpc_parse/parse_prs.c:prs_uint32s(997)
                      0074 sub_auths : 00000000 
[2008/07/31 10:26:57, 10] smbd/posix_acls.c:set_nt_acl(3324)
  set_nt_acl: called for file xxx
[2008/07/31 10:26:57, 5] smbd/posix_acls.c:unpack_nt_owners(949)
  unpack_nt_owners: validating owner_sids.
[2008/07/31 10:26:57, 10] passdb/lookup_sid.c:legacy_sid_to_uid(1260)
  LEGACY: mapping failed for sid S-1-5-21-2913048732-1697188782-3448811101-1001
[2008/07/31 10:26:57, 3] smbd/posix_acls.c:unpack_nt_owners(966)
  unpack_nt_owners: unable to validate owner sid for S-1-5-21-2913048732-1697188782-3448811101-1001
[2008/07/31 10:26:57, 10] locking/locking.c:parse_share_modes(523)
  parse_share_modes: delete_on_close: 0, num_share_modes: 1
[2008/07/31 10:26:57, 10] locking/locking.c:parse_share_modes(623)
  parse_share_modes: share_mode_entry[0]:  pid = 23345, share_access = 0x7, private_options = 0x0, access_mask = 0x120196, mid = 0x0, type= 0x3, file_id = 7, uid = 500, flags = 2, dev = 0x803, inode = 6801475
[2008/07/31 10:26:57, 10] smbd/oplock_linux.c:linux_release_kernel_oplock(191)
  linux_release_kernel_oplock: file xxx, dev = 803, inode = 6801475 file_id = 7 has kernel oplock state of 1.
[2008/07/31 10:26:57, 10] locking/posix.c:get_windows_lock_ref_count(545)
  get_windows_lock_count for file xxx = 0
[2008/07/31 10:26:57, 10] locking/posix.c:delete_windows_lock_ref_count(559)
  delete_windows_lock_ref_count for file xxx
[2008/07/31 10:26:57, 2] smbd/close.c:close_normal_file(406)
  corinna closed file xxx (numopen=0) NT_STATUS_OK
[2008/07/31 10:26:57, 5] smbd/files.c:file_free(454)
  freed files structure 7756 (0 used)
[2008/07/31 10:26:57, 3] smbd/error.c:error_packet_set(106)
  error packet at smbd/nttrans.c(1479) cmd=160 (SMBnttrans) NT_STATUS_ACCESS_DENIED
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:57, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0xa0
  smb_rcls=34
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51265
  smb_tid=2
  smb_pid=652
  smb_uid=101
  smb_mid=1664
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:59, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 35
[2008/07/31 10:26:59, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x23
[2008/07/31 10:26:59, 3] smbd/process.c:process_smb(1069)
  Transaction 27 of length 39
[2008/07/31 10:26:59, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:59, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0x71
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=1
  smb_pid=65279
  smb_uid=101
  smb_mid=1728
  smt_wct=0
  smb_bcc=0
[2008/07/31 10:26:59, 3] smbd/process.c:switch_message(927)
  switch message SMBtdis (pid 23345) conn 0x7f01d4ad1110
[2008/07/31 10:26:59, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2008/07/31 10:26:59, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2008/07/31 10:26:59, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2008/07/31 10:26:59, 5] smbd/uid.c:change_to_root_user(288)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2008/07/31 10:26:59, 4] smbd/vfs.c:vfs_ChDir(665)
  vfs_ChDir to /var/tmp
[2008/07/31 10:26:59, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2008/07/31 10:26:59, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2008/07/31 10:26:59, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2008/07/31 10:26:59, 5] smbd/uid.c:change_to_root_user(288)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2008/07/31 10:26:59, 3] smbd/service.c:close_cnum(1230)
  192.168.129.121 (192.168.129.121) closed connection to service IPC$
[2008/07/31 10:26:59, 3] smbd/connection.c:yield_connection(69)
  Yielding connection to IPC$
[2008/07/31 10:26:59, 4] smbd/vfs.c:vfs_ChDir(665)
  vfs_ChDir to /
[2008/07/31 10:26:59, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2008/07/31 10:26:59, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2008/07/31 10:26:59, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2008/07/31 10:26:59, 5] smbd/uid.c:change_to_root_user(288)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2008/07/31 10:26:59, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:59, 5] lib/util.c:show_msg(494)
  size=35
  smb_com=0x71
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51201
  smb_tid=1
  smb_pid=65279
  smb_uid=101
  smb_mid=1728
  smt_wct=0
  smb_bcc=0


More information about the samba-technical mailing list