Setting ACLs when creating files from Windows

Corinna Vinschen corinna at vinschen.de
Thu Jul 31 20:45:27 GMT 2008


On Jul 31 22:00, Volker Lendecke wrote:
> On Thu, Jul 31, 2008 at 09:49:51PM +0200, Corinna Vinschen wrote:
> > Why not?  The user with sid S-1-5-21-2913048732-1697188782-3448811101-1001
> > has authenticated itself and is mapped by Samba to the user with uid 500.
> 
> Not sure about that. You did not post the session setup part
> of the connection, there this would have been visible.

Sorry.  I attached now what happened when I cd'ed to the share for the
first time.  I'm somewhat puzzled that the Windows user SID never shows
up in the log.  Is it never transferred to the server?!?

> > Files are created as that user with uid 500.  Why is that mapping not
> > transparent when creating files with security descriptors using the SID
> > which has been mapped to the uid formerly?  That's hard to understand.
> > Isn't that what the smbusers file is supposed to accomplish?
> 
> What does "rpcclient localhost -U% -c 'lookupnames corinna'"
> say when run on the Samba box?

$ rpcclient localhost -U% -c 'lookupnames corinna'
corinna S-1-22-1-500 (User: 1)

> > How shall I know what UNIX user my Windows user is mapped to?  If
> > smbusers contains a mapping like "foo = bar", and a UNIX user bar
> > doesn't exist, how should I ever find out that I have to ask for a UNIX
> > user foo?  Sure, winbind seems to solve this problem, but that works
> > only for domains, not for standalone machines.

Oh and, even with winbind, there doesn't seem to be a way to map
a Windows user to an arbitrary, already existing UNIX account.

> Hmmm. Difficult. S-1-22-1-<uid> should always work, but how
> do you know your uid then? There's also a "lsa who am I"

I don't know my uid.  Not programatically.  I'm using the SID of the
current Windows user and the SID of its primary group in the security
descriptor in a call to NtCreateFile.

The mapping to the uid/gid is done on the Samba side.  For some reason
it's only done at authentication time, but the mapping doesn't work in
the later call to NtCreateFile with the aforementioned security
descriptor.  I would expect that Samba knows the SID of the
authenticated Windows user/primary group and maps them transparently to
the UNIX user/group in all subsequent calls where the Windows SID is
used.  Provided that Samba gets the SIDs (the entire user token?) from
the incoming Windows client at one point.

> call that gives you the name that you authenticated as, but
> as you say this might not be sufficient either. This btw is
> exactly where some RPC programming might come in extremely
> handy.... :-)

Maybe, but I'm rather wondering why the SID<->uid/sid mapping doesn't
work transparently from a Windows client POV which has no idea that the
remote machine is a Samba server, rather than a native Windows server.
And then there's
http://archives.free.net.ph/message/20080730.105641.9748f81b.en.html


Corinna
-------------- next part --------------
[2008/07/31 10:26:47, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 88
[2008/07/31 10:26:47, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x58
[2008/07/31 10:26:47, 3] smbd/process.c:process_smb(1069)
  Transaction 4 of length 92
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(494)
  size=88
  smb_com=0x75
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51207
  smb_tid=0
  smb_pid=65279
  smb_uid=101
  smb_mid=256
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=   88 (0x58)
  smb_vwv[ 2]=    8 (0x8)
  smb_vwv[ 3]=    1 (0x1)
  smb_bcc=45
[2008/07/31 10:26:47, 10] lib/util.c:dump_data(2264)
  [000] 00 5C 00 5C 00 43 00 41  00 4C 00 49 00 4D 00 45  .\.\.C.A .L.I.M.E
  [010] 00 52 00 4F 00 5C 00 43  00 4F 00 52 00 49 00 4E  .R.O.\.C .O.R.I.N
  [020] 00 4E 00 41 00 00 00 3F  3F 3F 3F 3F 00           .N.A...? ????.
[2008/07/31 10:26:47, 3] smbd/process.c:switch_message(927)
  switch message SMBtconX (pid 23345) conn 0x0
[2008/07/31 10:26:47, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2008/07/31 10:26:47, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2008/07/31 10:26:47, 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:47, 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:47, 4] smbd/reply.c:reply_tcon_and_X(506)
  Client requested device type [?????] for share [CORINNA]
[2008/07/31 10:26:47, 5] smbd/service.c:make_connection(1170)
  making a connection to 'homes' service [CORINNA] created at session setup time
[2008/07/31 10:26:47, 10] smbd/share_access.c:user_ok_token(232)
  user_ok_token: share corinna is ok for unix user corinna
[2008/07/31 10:26:47, 5] lib/username.c:Get_Pwnam_alloc(131)
  Finding user corinna
[2008/07/31 10:26:47, 5] lib/username.c:Get_Pwnam_internals(75)
  Trying _Get_Pwnam(), username as lowercase is corinna
[2008/07/31 10:26:47, 10] lib/util_pw.c:getpwnam_alloc(76)
  Got corinna from pwnam_cache
[2008/07/31 10:26:47, 5] lib/username.c:Get_Pwnam_internals(108)
  Get_Pwnam_internals did find user [corinna]!
[2008/07/31 10:26:47, 10] smbd/service.c:set_conn_connectpath(156)
  set_conn_connectpath: service corinna, connectpath = /home/corinna
[2008/07/31 10:26:47, 3] smbd/service.c:make_connection_snum(806)
  Connect path is '/home/corinna' for service [corinna]
[2008/07/31 10:26:47, 4] lib/sharesec.c:get_share_security(132)
  get_share_security: using default secdesc for corinna
[2008/07/31 10:26:47, 10] lib/util_seaccess.c:se_map_generic(176)
  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
[2008/07/31 10:26:47, 10] lib/util_seaccess.c:se_access_check(233)
  se_access_check: requested access 0x00000002, for NT token with 11 entries and first sid S-1-22-1-500.
[2008/07/31 10:26:47, 3] lib/util_seaccess.c:se_access_check(250)
[2008/07/31 10:26:47, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-22-1-500
  se_access_check: also S-1-22-2-11125
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
  se_access_check: also S-1-22-2-16
  se_access_check: also S-1-22-2-33
  se_access_check: also S-1-22-2-100
  se_access_check: also S-1-22-2-1000
  se_access_check: also S-1-22-2-101
  se_access_check: also S-1-22-2-58
  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask = 101f01ff, current desired = 2
[2008/07/31 10:26:47, 5] lib/util_seaccess.c:se_access_check(308)
  se_access_check: access (2) granted.
[2008/07/31 10:26:47, 3] smbd/vfs.c:vfs_init_default(95)
  Initialising default vfs hooks
[2008/07/31 10:26:47, 3] smbd/vfs.c:vfs_init_custom(128)
  Initialising custom vfs hooks from [/[Default VFS]/]
  Successfully loaded vfs module [/[Default VFS]/] with the new modules system
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #0 (type 0, layer 0)
  Making operation type 0 opaque [module /[Default VFS]/]
  Accepting operation type 0 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #1 (type 1, layer 0)
  Making operation type 1 opaque [module /[Default VFS]/]
  Accepting operation type 1 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #2 (type 2, layer 0)
  Making operation type 2 opaque [module /[Default VFS]/]
  Accepting operation type 2 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #3 (type 3, layer 0)
  Making operation type 3 opaque [module /[Default VFS]/]
  Accepting operation type 3 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #4 (type 4, layer 0)
  Making operation type 4 opaque [module /[Default VFS]/]
  Accepting operation type 4 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #5 (type 5, layer 0)
  Making operation type 5 opaque [module /[Default VFS]/]
  Accepting operation type 5 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #6 (type 6, layer 0)
  Making operation type 6 opaque [module /[Default VFS]/]
  Accepting operation type 6 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #7 (type 7, layer 0)
  Making operation type 7 opaque [module /[Default VFS]/]
  Accepting operation type 7 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #8 (type 8, layer 0)
  Making operation type 8 opaque [module /[Default VFS]/]
  Accepting operation type 8 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #9 (type 9, layer 0)
  Making operation type 9 opaque [module /[Default VFS]/]
  Accepting operation type 9 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #10 (type 10, layer 0)
  Making operation type 10 opaque [module /[Default VFS]/]
  Accepting operation type 10 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #11 (type 11, layer 0)
  Making operation type 11 opaque [module /[Default VFS]/]
  Accepting operation type 11 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #12 (type 12, layer 0)
  Making operation type 12 opaque [module /[Default VFS]/]
  Accepting operation type 12 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #13 (type 13, layer 0)
  Making operation type 13 opaque [module /[Default VFS]/]
  Accepting operation type 13 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #14 (type 14, layer 0)
  Making operation type 14 opaque [module /[Default VFS]/]
  Accepting operation type 14 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #15 (type 15, layer 0)
  Making operation type 15 opaque [module /[Default VFS]/]
  Accepting operation type 15 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #16 (type 16, layer 0)
  Making operation type 16 opaque [module /[Default VFS]/]
  Accepting operation type 16 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #17 (type 17, layer 0)
  Making operation type 17 opaque [module /[Default VFS]/]
  Accepting operation type 17 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #18 (type 18, layer 0)
  Making operation type 18 opaque [module /[Default VFS]/]
  Accepting operation type 18 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #19 (type 19, layer 0)
  Making operation type 19 opaque [module /[Default VFS]/]
  Accepting operation type 19 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #20 (type 20, layer 0)
  Making operation type 20 opaque [module /[Default VFS]/]
  Accepting operation type 20 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #21 (type 21, layer 0)
  Making operation type 21 opaque [module /[Default VFS]/]
  Accepting operation type 21 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #22 (type 22, layer 0)
  Making operation type 22 opaque [module /[Default VFS]/]
  Accepting operation type 22 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #23 (type 23, layer 0)
  Making operation type 23 opaque [module /[Default VFS]/]
  Accepting operation type 23 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #24 (type 24, layer 0)
  Making operation type 24 opaque [module /[Default VFS]/]
  Accepting operation type 24 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #25 (type 25, layer 0)
  Making operation type 25 opaque [module /[Default VFS]/]
  Accepting operation type 25 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #26 (type 26, layer 0)
  Making operation type 26 opaque [module /[Default VFS]/]
  Accepting operation type 26 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #27 (type 27, layer 0)
  Making operation type 27 opaque [module /[Default VFS]/]
  Accepting operation type 27 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #28 (type 28, layer 0)
  Making operation type 28 opaque [module /[Default VFS]/]
  Accepting operation type 28 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #29 (type 29, layer 0)
  Making operation type 29 opaque [module /[Default VFS]/]
  Accepting operation type 29 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #30 (type 30, layer 0)
  Making operation type 30 opaque [module /[Default VFS]/]
  Accepting operation type 30 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #31 (type 31, layer 0)
  Making operation type 31 opaque [module /[Default VFS]/]
  Accepting operation type 31 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #32 (type 32, layer 0)
  Making operation type 32 opaque [module /[Default VFS]/]
  Accepting operation type 32 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #33 (type 33, layer 0)
  Making operation type 33 opaque [module /[Default VFS]/]
  Accepting operation type 33 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #34 (type 34, layer 0)
  Making operation type 34 opaque [module /[Default VFS]/]
  Accepting operation type 34 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #35 (type 35, layer 0)
  Making operation type 35 opaque [module /[Default VFS]/]
  Accepting operation type 35 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #36 (type 36, layer 0)
  Making operation type 36 opaque [module /[Default VFS]/]
  Accepting operation type 36 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #37 (type 37, layer 0)
  Making operation type 37 opaque [module /[Default VFS]/]
  Accepting operation type 37 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #38 (type 38, layer 0)
  Making operation type 38 opaque [module /[Default VFS]/]
  Accepting operation type 38 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #39 (type 39, layer 0)
  Making operation type 39 opaque [module /[Default VFS]/]
  Accepting operation type 39 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #40 (type 40, layer 0)
  Making operation type 40 opaque [module /[Default VFS]/]
  Accepting operation type 40 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #41 (type 41, layer 0)
  Making operation type 41 opaque [module /[Default VFS]/]
  Accepting operation type 41 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #42 (type 42, layer 0)
  Making operation type 42 opaque [module /[Default VFS]/]
  Accepting operation type 42 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #43 (type 43, layer 0)
  Making operation type 43 opaque [module /[Default VFS]/]
  Accepting operation type 43 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #44 (type 44, layer 0)
  Making operation type 44 opaque [module /[Default VFS]/]
  Accepting operation type 44 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #45 (type 45, layer 0)
  Making operation type 45 opaque [module /[Default VFS]/]
  Accepting operation type 45 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #46 (type 46, layer 0)
  Making operation type 46 opaque [module /[Default VFS]/]
  Accepting operation type 46 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #47 (type 47, layer 0)
  Making operation type 47 opaque [module /[Default VFS]/]
  Accepting operation type 47 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #48 (type 48, layer 0)
  Making operation type 48 opaque [module /[Default VFS]/]
  Accepting operation type 48 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #49 (type 49, layer 0)
  Making operation type 49 opaque [module /[Default VFS]/]
  Accepting operation type 49 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #50 (type 50, layer 0)
  Making operation type 50 opaque [module /[Default VFS]/]
  Accepting operation type 50 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #51 (type 51, layer 0)
  Making operation type 51 opaque [module /[Default VFS]/]
  Accepting operation type 51 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #52 (type 52, layer 0)
  Making operation type 52 opaque [module /[Default VFS]/]
  Accepting operation type 52 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #53 (type 53, layer 0)
  Making operation type 53 opaque [module /[Default VFS]/]
  Accepting operation type 53 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #54 (type 54, layer 0)
  Making operation type 54 opaque [module /[Default VFS]/]
  Accepting operation type 54 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #55 (type 55, layer 0)
  Making operation type 55 opaque [module /[Default VFS]/]
  Accepting operation type 55 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #56 (type 56, layer 0)
  Making operation type 56 opaque [module /[Default VFS]/]
  Accepting operation type 56 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #57 (type 57, layer 0)
  Making operation type 57 opaque [module /[Default VFS]/]
  Accepting operation type 57 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #58 (type 58, layer 0)
  Making operation type 58 opaque [module /[Default VFS]/]
  Accepting operation type 58 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #59 (type 59, layer 0)
  Making operation type 59 opaque [module /[Default VFS]/]
  Accepting operation type 59 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #60 (type 60, layer 0)
  Making operation type 60 opaque [module /[Default VFS]/]
  Accepting operation type 60 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #61 (type 61, layer 0)
  Making operation type 61 opaque [module /[Default VFS]/]
  Accepting operation type 61 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #62 (type 62, layer 0)
  Making operation type 62 opaque [module /[Default VFS]/]
  Accepting operation type 62 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #63 (type 63, layer 0)
  Making operation type 63 opaque [module /[Default VFS]/]
  Accepting operation type 63 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #64 (type 64, layer 0)
  Making operation type 64 opaque [module /[Default VFS]/]
  Accepting operation type 64 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #65 (type 65, layer 0)
  Making operation type 65 opaque [module /[Default VFS]/]
  Accepting operation type 65 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #66 (type 66, layer 0)
  Making operation type 66 opaque [module /[Default VFS]/]
  Accepting operation type 66 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #67 (type 67, layer 0)
  Making operation type 67 opaque [module /[Default VFS]/]
  Accepting operation type 67 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #68 (type 68, layer 0)
  Making operation type 68 opaque [module /[Default VFS]/]
  Accepting operation type 68 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #69 (type 69, layer 0)
  Making operation type 69 opaque [module /[Default VFS]/]
  Accepting operation type 69 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #70 (type 70, layer 0)
  Making operation type 70 opaque [module /[Default VFS]/]
  Accepting operation type 70 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #71 (type 71, layer 0)
  Making operation type 71 opaque [module /[Default VFS]/]
  Accepting operation type 71 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #72 (type 72, layer 0)
  Making operation type 72 opaque [module /[Default VFS]/]
  Accepting operation type 72 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #73 (type 73, layer 0)
  Making operation type 73 opaque [module /[Default VFS]/]
  Accepting operation type 73 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #74 (type 74, layer 0)
  Making operation type 74 opaque [module /[Default VFS]/]
  Accepting operation type 74 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #75 (type 75, layer 0)
  Making operation type 75 opaque [module /[Default VFS]/]
  Accepting operation type 75 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #76 (type 76, layer 0)
  Making operation type 76 opaque [module /[Default VFS]/]
  Accepting operation type 76 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #77 (type 77, layer 0)
  Making operation type 77 opaque [module /[Default VFS]/]
  Accepting operation type 77 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #78 (type 78, layer 0)
  Making operation type 78 opaque [module /[Default VFS]/]
  Accepting operation type 78 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #79 (type 79, layer 0)
  Making operation type 79 opaque [module /[Default VFS]/]
  Accepting operation type 79 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #80 (type 80, layer 0)
  Making operation type 80 opaque [module /[Default VFS]/]
  Accepting operation type 80 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #81 (type 81, layer 0)
  Making operation type 81 opaque [module /[Default VFS]/]
  Accepting operation type 81 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #82 (type 82, layer 0)
  Making operation type 82 opaque [module /[Default VFS]/]
  Accepting operation type 82 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #83 (type 83, layer 0)
  Making operation type 83 opaque [module /[Default VFS]/]
  Accepting operation type 83 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #84 (type 84, layer 0)
  Making operation type 84 opaque [module /[Default VFS]/]
  Accepting operation type 84 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #85 (type 85, layer 0)
  Making operation type 85 opaque [module /[Default VFS]/]
  Accepting operation type 85 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #86 (type 86, layer 0)
  Making operation type 86 opaque [module /[Default VFS]/]
  Accepting operation type 86 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #87 (type 87, layer 0)
  Making operation type 87 opaque [module /[Default VFS]/]
  Accepting operation type 87 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #88 (type 88, layer 0)
  Making operation type 88 opaque [module /[Default VFS]/]
  Accepting operation type 88 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #89 (type 89, layer 0)
  Making operation type 89 opaque [module /[Default VFS]/]
  Accepting operation type 89 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #90 (type 90, layer 0)
  Making operation type 90 opaque [module /[Default VFS]/]
  Accepting operation type 90 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #91 (type 91, layer 0)
  Making operation type 91 opaque [module /[Default VFS]/]
  Accepting operation type 91 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #92 (type 92, layer 0)
  Making operation type 92 opaque [module /[Default VFS]/]
  Accepting operation type 92 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #93 (type 93, layer 0)
  Making operation type 93 opaque [module /[Default VFS]/]
  Accepting operation type 93 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/vfs.c:vfs_init_custom(174)
  Checking operation #94 (type 94, layer 0)
  Making operation type 94 opaque [module /[Default VFS]/]
  Accepting operation type 94 from module /[Default VFS]/
[2008/07/31 10:26:47, 5] smbd/connection.c:claim_connection(182)
  claiming corinna 0
[2008/07/31 10:26:47, 10] smbd/share_access.c:user_ok_token(232)
  user_ok_token: share corinna is ok for unix user corinna
[2008/07/31 10:26:47, 10] smbd/share_access.c:is_share_read_only_for_token(274)
  is_share_read_only_for_user: share corinna is read-write for unix user corinna
[2008/07/31 10:26:47, 4] lib/sharesec.c:get_share_security(132)
  get_share_security: using default secdesc for corinna
[2008/07/31 10:26:47, 10] lib/util_seaccess.c:se_map_generic(176)
  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
[2008/07/31 10:26:47, 10] lib/util_seaccess.c:se_access_check(233)
  se_access_check: requested access 0x00000002, for NT token with 11 entries and first sid S-1-22-1-500.
[2008/07/31 10:26:47, 3] lib/util_seaccess.c:se_access_check(250)
[2008/07/31 10:26:47, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-22-1-500
  se_access_check: also S-1-22-2-11125
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
  se_access_check: also S-1-22-2-16
  se_access_check: also S-1-22-2-33
  se_access_check: also S-1-22-2-100
  se_access_check: also S-1-22-2-1000
  se_access_check: also S-1-22-2-101
  se_access_check: also S-1-22-2-58
  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask = 101f01ff, current desired = 2
[2008/07/31 10:26:47, 5] lib/util_seaccess.c:se_access_check(308)
  se_access_check: access (2) granted.
[2008/07/31 10:26:47, 4] lib/sharesec.c:get_share_security(132)
  get_share_security: using default secdesc for corinna
[2008/07/31 10:26:47, 10] lib/util_seaccess.c:se_map_generic(176)
  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
[2008/07/31 10:26:47, 10] lib/util_seaccess.c:se_access_check(233)
  se_access_check: requested access 0x00000002, for NT token with 11 entries and first sid S-1-22-1-500.
[2008/07/31 10:26:47, 3] lib/util_seaccess.c:se_access_check(250)
[2008/07/31 10:26:47, 3] lib/util_seaccess.c:se_access_check(251)
  se_access_check: user sid is S-1-22-1-500
  se_access_check: also S-1-22-2-11125
  se_access_check: also S-1-1-0
  se_access_check: also S-1-5-2
  se_access_check: also S-1-5-11
  se_access_check: also S-1-22-2-16
  se_access_check: also S-1-22-2-33
  se_access_check: also S-1-22-2-100
  se_access_check: also S-1-22-2-1000
  se_access_check: also S-1-22-2-101
  se_access_check: also S-1-22-2-58
  se_access_check: ACE 0: type 0, flags = 0x00, SID = S-1-1-0 mask = 101f01ff, current desired = 2
[2008/07/31 10:26:47, 5] lib/util_seaccess.c:se_access_check(308)
  se_access_check: access (2) granted.
[2008/07/31 10:26:47, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (500, 11125) - sec_ctx_stack_ndx = 0
[2008/07/31 10:26:47, 5] auth/auth_util.c:debug_nt_user_token(454)
  NT user token of user S-1-22-1-500
  contains 11 SIDs
  SID[  0]: S-1-22-1-500
  SID[  1]: S-1-22-2-11125
  SID[  2]: S-1-1-0
  SID[  3]: S-1-5-2
  SID[  4]: S-1-5-11
  SID[  5]: S-1-22-2-16
  SID[  6]: S-1-22-2-33
  SID[  7]: S-1-22-2-100
  SID[  8]: S-1-22-2-1000
  SID[  9]: S-1-22-2-101
  SID[ 10]: S-1-22-2-58
  SE_PRIV  0x0 0x0 0x0 0x0
[2008/07/31 10:26:47, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 500
  Primary group is 11125 and contains 7 supplementary groups
  Group[  0]: 11125
  Group[  1]: 16
  Group[  2]: 33
  Group[  3]: 100
  Group[  4]: 1000
  Group[  5]: 101
  Group[  6]: 58
[2008/07/31 10:26:47, 5] smbd/uid.c:change_to_user(273)
  change_to_user uid=(500,500) gid=(0,11125)
[2008/07/31 10:26:47, 1] smbd/service.c:make_connection_snum(1033)
  192.168.129.121 (192.168.129.121) connect to service corinna initially as user corinna (uid=500, gid=11125) (pid 23345)
[2008/07/31 10:26:47, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2008/07/31 10:26:47, 5] auth/auth_util.c:debug_nt_user_token(448)
  NT user token: (NULL)
[2008/07/31 10:26:47, 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:47, 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:47, 3] smbd/reply.c:reply_tcon_and_X(574)
  tconX service=CORINNA 
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(494)
  size=62
  smb_com=0x75
  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=256
  smt_wct=7
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    1 (0x1)
  smb_vwv[ 3]=  511 (0x1FF)
  smb_vwv[ 4]=   31 (0x1F)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_bcc=13
[2008/07/31 10:26:47, 10] lib/util.c:dump_data(2264)
  [000] 41 3A 00 4E 00 54 00 46  00 53 00 00 00           A:.N.T.F .S...
[2008/07/31 10:26:47, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 156
[2008/07/31 10:26:47, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x9c
[2008/07/31 10:26:47, 3] smbd/process.c:process_smb(1069)
  Transaction 5 of length 160
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=320
  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:47, 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:47, 3] smbd/process.c:switch_message(927)
  switch message SMBnttrans (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:47, 3] smbd/sec_ctx.c:set_sec_ctx(241)
  setting sec ctx (500, 11125) - sec_ctx_stack_ndx = 0
[2008/07/31 10:26:47, 5] auth/auth_util.c:debug_nt_user_token(454)
  NT user token of user S-1-22-1-500
  contains 11 SIDs
  SID[  0]: S-1-22-1-500
  SID[  1]: S-1-22-2-11125
  SID[  2]: S-1-1-0
  SID[  3]: S-1-5-2
  SID[  4]: S-1-5-11
  SID[  5]: S-1-22-2-16
  SID[  6]: S-1-22-2-33
  SID[  7]: S-1-22-2-100
  SID[  8]: S-1-22-2-1000
  SID[  9]: S-1-22-2-101
  SID[ 10]: S-1-22-2-58
  SE_PRIV  0x0 0x0 0x0 0x0
[2008/07/31 10:26:47, 5] auth/auth_util.c:debug_unix_user_token(474)
  UNIX token of user 500
  Primary group is 11125 and contains 7 supplementary groups
  Group[  0]: 11125
  Group[  1]: 16
  Group[  2]: 33
  Group[  3]: 100
  Group[  4]: 1000
  Group[  5]: 101
  Group[  6]: 58
[2008/07/31 10:26:47, 5] smbd/uid.c:change_to_user(273)
  change_to_user uid=(500,500) gid=(0,11125)
[2008/07/31 10:26:47, 4] smbd/vfs.c:vfs_ChDir(665)
  vfs_ChDir to /home/corinna
[2008/07/31 10:26:47, 5] smbd/nttrans.c:call_nt_transact_create(1176)
  call_nt_transact_create
[2008/07/31 10:26:47, 5] smbd/filename.c:unix_convert(147)
  unix_convert called on file ""
[2008/07/31 10:26:47, 5] smbd/filename.c:unix_convert(176)
  conversion finished "" -> .
[2008/07/31 10:26:47, 10] smbd/trans2.c:read_ea_list_entry(489)
  read_ea_list_entry: read ea name NfsActOnLink
[2008/07/31 10:26:47, 3] smbd/dosmode.c:unix_mode(142)
  unix_mode(.) returning 0644
[2008/07/31 10:26:47, 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:47, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:47, 10] smbd/open.c:open_file_ntcreate(1347)
  open_file_ntcreate: fname=., after mapping access_mask=0x20088
[2008/07/31 10:26:47, 5] smbd/files.c:file_new(123)
  allocated file structure 3654, fnum = 7750 (1 used)
[2008/07/31 10:26:47, 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:47, 5] smbd/files.c:file_free(454)
  freed files structure 7750 (0 used)
[2008/07/31 10:26:47, 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:47, 5] smbd/files.c:file_new(123)
  allocated file structure 3655, fnum = 7751 (1 used)
[2008/07/31 10:26:47, 10] locking/locking.c:unparse_share_modes(681)
  unparse_share_modes: del: 0, tok = 0, num: 1
[2008/07/31 10:26:47, 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 = 2, uid = 500, flags = 2, dev = 0x803, inode = 6799362
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:47, 5] smbd/nttrans.c:call_nt_transact_create(1618)
  call_nt_transact_create: open name = .
[2008/07/31 10:26:47, 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:47, 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:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=320
  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:47, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 47 1E 01  00 00 00 00 00 00 00 80  .....G.. ........
  [010] 4E 52 86 E6 F2 C8 01 80  4E 52 86 E6 F2 C8 01 80  NR...... NR......
  [020] 47 55 1B E7 F2 C8 01 80  47 55 1B E7 F2 C8 01 10  GU...... GU......
  [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:47, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 72
[2008/07/31 10:26:47, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x48
[2008/07/31 10:26:47, 3] smbd/process.c:process_smb(1069)
  Transaction 6 of length 76
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=384
  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:47, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 47 1E EC 03                              ...G... 
[2008/07/31 10:26:47, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:47, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:47, 3] smbd/trans2.c:call_trans2qfilepathinfo(3244)
  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1004
[2008/07/31 10:26:47, 3] smbd/trans2.c:call_trans2qfilepathinfo(3355)
  call_trans2qfilepathinfo . (fnum = 7751) level=1004 call=7 total_data=0
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode(371)
  dos_mode: .
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode_from_sbuf(188)
  dos_mode_from_sbuf returning d
[2008/07/31 10:26:47, 8] smbd/dosmode.c:dos_mode(409)
  dos_mode returning d
[2008/07/31 10:26:47, 10] smbd/trans2.c:call_trans2qfilepathinfo(3590)
  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
[2008/07/31 10:26:47, 5] smbd/trans2.c:call_trans2qfilepathinfo(3600)
  SMB_QFBI - create: Thu Jul 31 10:22:09 2008
   access: Thu Jul 31 10:22:09 2008
   write: Thu Jul 31 10:26:19 2008
   change: Thu Jul 31 10:26:19 2008
   mode: 10
[2008/07/31 10:26:47, 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:47, 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:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=384
  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:47, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 80 4E 52  86 E6 F2 C8 01 80 4E 52  ......NR ......NR
  [010] 86 E6 F2 C8 01 80 47 55  1B E7 F2 C8 01 80 47 55  ......GU ......GU
  [020] 1B E7 F2 C8 01 10 00 00  00 00 00 00 00           ........ .....
[2008/07/31 10:26:47, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 70
[2008/07/31 10:26:47, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x46
[2008/07/31 10:26:47, 3] smbd/process.c:process_smb(1069)
  Transaction 7 of length 74
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=448
  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:47, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 02 01                                    ..... 
[2008/07/31 10:26:47, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:47, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:47, 3] smbd/trans2.c:call_trans2qfsinfo(2285)
  call_trans2qfsinfo: level = 258
[2008/07/31 10:26:47, 5] smbd/trans2.c:call_trans2qfsinfo(2402)
  call_trans2qfsinfo : SMB_QUERY_FS_VOLUME_INFO namelen = 7, vol=corinna serv=corinna
[2008/07/31 10:26:47, 9] smbd/trans2.c:send_trans2_replies(712)
  t2_rep: params_sent_thistime = 0, data_sent_thistime = 32, useable_space = 131012
[2008/07/31 10:26:47, 9] smbd/trans2.c:send_trans2_replies(714)
  t2_rep: params_to_send = 0, data_to_send = 32, paramsize = 0, datasize = 32
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(494)
  size=88
  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=448
  smt_wct=10
  smb_vwv[ 0]=    0 (0x0)
  smb_vwv[ 1]=   32 (0x20)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=    0 (0x0)
  smb_vwv[ 4]=   56 (0x38)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=   32 (0x20)
  smb_vwv[ 7]=   56 (0x38)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_bcc=33
[2008/07/31 10:26:47, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 00 00 00 00 00  00 5D 11 29 23 0E 00 00  ........ .].)#...
  [010] 00 00 00 63 00 6F 00 72  00 69 00 6E 00 6E 00 61  ...c.o.r .i.n.n.a
  [020] 00                                                . 
[2008/07/31 10:26:47, 4] smbd/trans2.c:call_trans2qfsinfo(2745)
  SMBtrans2 info_level = 258
[2008/07/31 10:26:47, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 70
[2008/07/31 10:26:47, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x46
[2008/07/31 10:26:47, 3] smbd/process.c:process_smb(1069)
  Transaction 8 of length 74
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=512
  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:47, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 05 01                                    ..... 
[2008/07/31 10:26:47, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:47, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:47, 3] smbd/trans2.c:call_trans2qfsinfo(2285)
  call_trans2qfsinfo: level = 261
[2008/07/31 10:26:47, 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:47, 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:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=512
  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:47, 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:47, 4] smbd/trans2.c:call_trans2qfsinfo(2745)
  SMBtrans2 info_level = 261
[2008/07/31 10:26:47, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 70
[2008/07/31 10:26:47, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x46
[2008/07/31 10:26:47, 3] smbd/process.c:process_smb(1069)
  Transaction 9 of length 74
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=576
  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:47, 10] lib/util.c:dump_data(2264)
  [000] 00 00 00 F0 03                                    ..... 
[2008/07/31 10:26:47, 3] smbd/process.c:switch_message(927)
  switch message SMBtrans2 (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:47, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:47, 3] smbd/trans2.c:call_trans2qfsinfo(2285)
  call_trans2qfsinfo: level = 1008
[2008/07/31 10:26:47, 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:47, 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:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=576
  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:47, 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:47, 4] smbd/trans2.c:call_trans2qfsinfo(2745)
  SMBtrans2 info_level = 1008
[2008/07/31 10:26:47, 10] lib/util_sock.c:read_smb_length_return_keepalive(623)
  got smb length of 41
[2008/07/31 10:26:47, 6] smbd/process.c:process_smb(1068)
  got message type 0x0 of len 0x29
[2008/07/31 10:26:47, 3] smbd/process.c:process_smb(1069)
  Transaction 10 of length 45
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=640
  smt_wct=3
  smb_vwv[ 0]= 7751 (0x1E47)
  smb_vwv[ 1]=65535 (0xFFFF)
  smb_vwv[ 2]=65535 (0xFFFF)
  smb_bcc=0
[2008/07/31 10:26:47, 3] smbd/process.c:switch_message(927)
  switch message SMBclose (pid 23345) conn 0x7f01d4ad2760
[2008/07/31 10:26:47, 4] smbd/uid.c:change_to_user(183)
  change_to_user: Skipping user change - already user
[2008/07/31 10:26:47, 3] smbd/reply.c:reply_close(3329)
  close directory fnum=7751
[2008/07/31 10:26:47, 10] locking/locking.c:parse_share_modes(523)
  parse_share_modes: delete_on_close: 0, num_share_modes: 1
[2008/07/31 10:26:47, 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 = 2, uid = 500, flags = 2, dev = 0x803, inode = 6799362
[2008/07/31 10:26:47, 5] smbd/files.c:file_free(454)
  freed files structure 7751 (0 used)
[2008/07/31 10:26:47, 5] lib/util.c:show_msg(484)
[2008/07/31 10:26:47, 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=640
  smt_wct=0
  smb_bcc=0


More information about the samba-technical mailing list