Attachment 5589 Details for Bug 6917 – Level 10 debug log during uninherit, copy, edit and apply of ACLs on a file

Level 10 debug log during uninherit, copy, edit and apply of ACLs on a file

samba.log.lab06-4_uninherit_copy_edit_apply.txt (text/plain), 117.63 KB, created by Roel van Meer on 2010-04-02 08:40:43 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Roel van Meer

Created: 2010-04-02 08:40:43 UTC

Size: 117.63 KB

patch

obsolete

>
>[2010/04/02 15:04:10.854546,  3] smbd/process.c:1485(process_smb)
>  Transaction 308 of length 80 (0 toread)
>[2010/04/02 15:04:10.854618,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtconX (pid 27822) conn 0x0
>[2010/04/02 15:04:10.854639,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.854733,  3] lib/access.c:389(check_access)
>  check_access: no hostnames in host allow/deny list.
>[2010/04/02 15:04:10.854875,  2] lib/access.c:406(check_access)
>  Allowed connection from  (10.1.90.6)
>[2010/04/02 15:04:10.854917,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.854937,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.854954,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.855346,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.855378,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.855411,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.855429,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.855640,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.855701,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.855737,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.855756,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.855789,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.855831,  3] smbd/service.c:807(make_connection_snum)
>  Connect path is '/tmp' for service [IPC$]
>[2010/04/02 15:04:10.855863,  3] smbd/vfs.c:97(vfs_init_default)
>  Initialising default vfs hooks
>[2010/04/02 15:04:10.855881,  3] smbd/vfs.c:122(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2010/04/02 15:04:10.855899, 10] smbd/vfs.c:48(vfs_find_backend_entry)
>  vfs_find_backend_entry called for /[Default VFS]/
>  Successfully loaded vfs module [/[Default VFS]/] with the new modules system
>[2010/04/02 15:04:10.855981,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid @Administrators does not start with 'S-'.
>[2010/04/02 15:04:10.856023,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856042,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856060,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856433,  2] passdb/pdb_ldap.c:2446(init_group_from_ldap)
>  init_group_from_ldap: Entry found for group: 544
>[2010/04/02 15:04:10.856484,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856512,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856538,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856556,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856606,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856628,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856646,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856663,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856695,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856736,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856776,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856808,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.856843,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856886,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.856928,  3] smbd/service.c:1069(make_connection_snum)
>  lab06 (10.1.90.6) connect to service IPC$ initially as user leerling1 (uid=6683, gid=100) (pid 27822)
>[2010/04/02 15:04:10.856954,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.857008,  3] smbd/reply.c:846(reply_tcon_and_X)
>  tconX service=IPC$ 
>[2010/04/02 15:04:10.857555,  3] smbd/process.c:1485(process_smb)
>  Transaction 309 of length 104 (0 toread)
>[2010/04/02 15:04:10.857590,  3] smbd/process.c:1294(switch_message)
>  switch message SMBntcreateX (pid 27822) conn 0xb8e608f0
>[2010/04/02 15:04:10.857625,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.857651,  4] smbd/vfs.c:721(vfs_ChDir)
>  vfs_ChDir to /tmp
>[2010/04/02 15:04:10.857693,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.857714,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.857732,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.857776,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.857797,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.857817,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.857834,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.857885,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.857924,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.857946,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.857963,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:10.858000,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:10.858640,  3] smbd/process.c:1485(process_smb)
>  Transaction 310 of length 140 (0 toread)
>[2010/04/02 15:04:10.858664,  3] smbd/process.c:1294(switch_message)
>  switch message SMBwriteX (pid 27822) conn 0xb8e608f0
>[2010/04/02 15:04:10.858698,  3] rpc_server/srv_pipe.c:1667(api_pipe_bind_req)
>  api_pipe_bind_req: \PIPE\dssetup -> \PIPE\dssetup
>[2010/04/02 15:04:10.858719,  3] rpc_server/srv_pipe.c:998(check_bind_req)
>  check_bind_req for \lsarpc
>[2010/04/02 15:04:10.858758,  3] smbd/pipes.c:352(pipe_write_andx_done)
>  writeX-IPC nwritten=72
>[2010/04/02 15:04:10.859140,  3] smbd/process.c:1485(process_smb)
>  Transaction 311 of length 63 (0 toread)
>[2010/04/02 15:04:10.859162,  3] smbd/process.c:1294(switch_message)
>  switch message SMBreadX (pid 27822) conn 0xb8e608f0
>[2010/04/02 15:04:10.859205,  3] smbd/pipes.c:462(pipe_read_andx_done)
>  readX-IPC min=1024 max=1024 nread=68
>[2010/04/02 15:04:10.859679,  3] smbd/process.c:1485(process_smb)
>  Transaction 312 of length 114 (0 toread)
>[2010/04/02 15:04:10.859705,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtrans (pid 27822) conn 0xb8e608f0
>[2010/04/02 15:04:10.859728,  3] smbd/ipc.c:545(handle_trans)
>  trans <\PIPE\> data=26 params=0 setup=2
>[2010/04/02 15:04:10.859749,  3] smbd/ipc.c:496(named_pipe)
>  named pipe command on <> name
>[2010/04/02 15:04:10.859767,  3] smbd/ipc.c:460(api_fd_reply)
>  Got API command 0x26 on pipe "lsarpc" (pnum 1e05)
>[2010/04/02 15:04:10.859802,  3] rpc_server/srv_pipe_hnd.c:344(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 72
>[2010/04/02 15:04:10.859837,  3] rpc_server/srv_pipe.c:2414(api_rpcTNP)
>  api_rpcTNP: rpc command: DSSETUP_DSROLEGETPRIMARYDOMAININFORMATION
>[2010/04/02 15:04:10.859876,  3] rpc_server/srv_pipe_hnd.c:344(free_pipe_context)
>  free_pipe_context: destroying talloc pool of size 36
>[2010/04/02 15:04:10.860349,  3] smbd/process.c:1485(process_smb)
>  Transaction 313 of length 45 (0 toread)
>[2010/04/02 15:04:10.860372,  3] smbd/process.c:1294(switch_message)
>  switch message SMBclose (pid 27822) conn 0xb8e608f0
>[2010/04/02 15:04:10.860397,  3] smbd/reply.c:4634(reply_close)
>  close fd=-1 fnum=7685 (numopen=1)
>[2010/04/02 15:04:21.782387,  3] smbd/process.c:1485(process_smb)
>  Transaction 314 of length 39 (0 toread)
>[2010/04/02 15:04:21.782456,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtdis (pid 27822) conn 0xb8e608f0
>[2010/04/02 15:04:21.782476,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:21.782512,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:21.782539,  3] smbd/service.c:1250(close_cnum)
>  lab06 (10.1.90.6) closed connection to service IPC$
>[2010/04/02 15:04:21.782590,  3] smbd/connection.c:31(yield_connection)
>  Yielding connection to IPC$
>[2010/04/02 15:04:21.782643,  4] smbd/vfs.c:721(vfs_ChDir)
>  vfs_ChDir to /
>[2010/04/02 15:04:21.782665,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.675124,  3] smbd/process.c:1485(process_smb)
>  Transaction 315 of length 128 (0 toread)
>[2010/04/02 15:04:29.675210,  3] smbd/process.c:1294(switch_message)
>  switch message SMBntcreateX (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.675235,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.675273,  4] smbd/vfs.c:721(vfs_ChDir)
>  vfs_ChDir to /home/vol1/shares/aclshare
>[2010/04/02 15:04:29.675329,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.675376, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.675397,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.675431,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.675454, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.675472,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.675499,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(file-with-acls.txt) returning 0660
>[2010/04/02 15:04:29.675519,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.675541, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.675573,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.675611, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.675631, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.675676, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.675709, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.675759, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.675777, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.675799, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.675815, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.675843, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.675860, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.675877, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.675893, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.675910, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.675926, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.675943, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.675974, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.676004, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.676088, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.676757, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.677279, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.677300, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.677317, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.677367,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.677389,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.677406,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.677445,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.677530,  2] smbd/open.c:631(open_file)
>  leerling1 opened file file-with-acls.txt read=No write=No (numopen=1)
>[2010/04/02 15:04:29.677611, 10] smbd/file_access.c:185(can_access_file_data)
>  can_access_file_data: requesting 0x2 on file file-with-acls.txt
>[2010/04/02 15:04:29.678093,  3] smbd/process.c:1485(process_smb)
>  Transaction 316 of length 76 (0 toread)
>[2010/04/02 15:04:29.678114,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtrans2 (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.678135,  3] smbd/trans2.c:4996(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1006
>[2010/04/02 15:04:29.678162,  3] smbd/trans2.c:5209(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo file-with-acls.txt (fnum = 7686) level=1006 call=7 total_data=0
>[2010/04/02 15:04:29.678640,  3] smbd/process.c:1485(process_smb)
>  Transaction 317 of length 76 (0 toread)
>[2010/04/02 15:04:29.678688,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtrans2 (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.678708,  3] smbd/trans2.c:4996(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1004
>[2010/04/02 15:04:29.678734,  3] smbd/trans2.c:5209(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo file-with-acls.txt (fnum = 7686) level=1004 call=7 total_data=0
>[2010/04/02 15:04:29.679259,  3] smbd/process.c:1485(process_smb)
>  Transaction 318 of length 264 (0 toread)
>[2010/04/02 15:04:29.679282,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.679303,  3] smbd/nttrans.c:1899(call_nt_transact_set_security_desc)
>  call_nt_transact_set_security_desc: file = file-with-acls.txt, sent 0x80000004
>[2010/04/02 15:04:29.679328, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.679346, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.679363, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.679402, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.679420, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.679437, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.679469, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.679485, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.679501, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.679521, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.679538, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.679555, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.679571, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.679613, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.679630, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.679646, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.679662, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.679699, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.679759, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.680189, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.680685, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.680719, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.680749, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.680772,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.680795,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.680827,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.680864,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.680926, 10] smbd/posix_acls.c:3840(set_nt_acl)
>  set_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.680948,  5] smbd/posix_acls.c:1191(unpack_nt_owners)
>  unpack_nt_owners: validating owner_sids.
>[2010/04/02 15:04:29.680966,  3] smbd/posix_acls.c:1213(unpack_nt_owners)
>  unpack_nt_owners: owner sid mapped to uid 6683
>[2010/04/02 15:04:29.681000,  3] smbd/posix_acls.c:1235(unpack_nt_owners)
>  unpack_nt_owners: group sid mapped to gid 100
>[2010/04/02 15:04:29.681017,  5] smbd/posix_acls.c:1238(unpack_nt_owners)
>  unpack_nt_owners: owner_sids validated.
>[2010/04/02 15:04:29.681036, 10] smbd/posix_acls.c:1904(create_canon_ace_lists)
>  create_canon_ace_lists: adding file ACL:
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.681065, 10] smbd/posix_acls.c:1904(create_canon_ace_lists)
>  create_canon_ace_lists: adding file ACL:
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.681486, 10] smbd/posix_acls.c:1904(create_canon_ace_lists)
>  create_canon_ace_lists: adding file ACL:
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.681567, 10] smbd/posix_acls.c:1506(check_owning_objs)
>  check_owning_objs: ACL had owning user/group entries.
>[2010/04/02 15:04:29.681609, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: file ace - before merge
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.682063, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: dir ace - before merge
>[2010/04/02 15:04:29.682083, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: file ace - before deny
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.682557, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: dir ace - before deny
>[2010/04/02 15:04:29.682577, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: file ace - before valid
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.683091, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: dir ace - before valid
>[2010/04/02 15:04:29.683136,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(file-with-acls.txt) returning 0660
>[2010/04/02 15:04:29.683156, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: file ace - return
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.683678, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: dir ace - return
>[2010/04/02 15:04:29.683700, 10] smbd/posix_acls.c:2722(set_canon_ace_list)
>  set_canon_ace_list: setting ACL:
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.684241, 10] smbd/posix_acls.c:2822(set_canon_ace_list)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.684267, 10] smbd/posix_acls.c:2822(set_canon_ace_list)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.684679, 10] smbd/posix_acls.c:2822(set_canon_ace_list)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.684807,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.684832,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.684849,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.684894,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.684915, 10] smbd/posix_acls.c:194(create_pai_buf_v2)
>  create_pai_buf_v2: num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.684932, 10] smbd/posix_acls.c:212(create_pai_buf_v2)
>  create_pai_buf_v2: sd_type = 0x8004
>[2010/04/02 15:04:29.684949, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.684965, 10] smbd/posix_acls.c:228(create_pai_buf_v2)
>  create_pai_buf_v2: entry 0 [0x0] [0x2] [0xffffffff]
>[2010/04/02 15:04:29.684981, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.684997, 10] smbd/posix_acls.c:228(create_pai_buf_v2)
>  create_pai_buf_v2: entry 1 [0x0] [0x0] [0x1a1b]
>[2010/04/02 15:04:29.685029, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.685046, 10] smbd/posix_acls.c:228(create_pai_buf_v2)
>  create_pai_buf_v2: entry 2 [0x0] [0x1] [0x64]
>[2010/04/02 15:04:29.685071, 10] smbd/posix_acls.c:285(store_inheritance_attributes)
>  store_inheritance_attribute: type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.685116, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.685135, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.685182, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.685201, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.685218, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.685234, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.685263, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.685279, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.685300, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.685316, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.685333, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.685349, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.685365, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.685381, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.685397, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.685427, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.685450, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.685525, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.685968, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.686453, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.686473, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.686491, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.686546, 10] modules/vfs_acl_xattr.c:104(store_acl_blob_fsp)
>  store_acl_blob_fsp: storing blob length 256 on file file-with-acls.txt
>[2010/04/02 15:04:29.686566,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.686586,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.686603,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.686659,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.687176,  3] smbd/process.c:1485(process_smb)
>  Transaction 319 of length 45 (0 toread)
>[2010/04/02 15:04:29.687200,  3] smbd/process.c:1294(switch_message)
>  switch message SMBclose (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.687234,  3] smbd/reply.c:4634(reply_close)
>  close fd=-1 fnum=7686 (numopen=1)
>[2010/04/02 15:04:29.687274,  2] smbd/close.c:656(close_normal_file)
>  leerling1 closed file file-with-acls.txt (numopen=0) NT_STATUS_OK
>[2010/04/02 15:04:29.689740,  3] smbd/process.c:1485(process_smb)
>  Transaction 320 of length 110 (0 toread)
>[2010/04/02 15:04:29.689768,  3] smbd/process.c:1294(switch_message)
>  switch message SMBntcreateX (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.689809, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.689828, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.689904, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.689927, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.689944, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.689967, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.690049, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.690095, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.690202, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.690221, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.690238, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.690275,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.690312,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.690329,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.690361,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.690381, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.690404,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.690422,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.690438, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.690469, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.690486, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.690502, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.690541,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [Thumbs.db] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.690574, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [Thumbs.db] -> [/home/vol1/shares/aclshare/Thumbs.db]
>[2010/04/02 15:04:29.690591,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: Thumbs.db reduced to /home/vol1/shares/aclshare/Thumbs.db
>[2010/04/02 15:04:29.690624,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [Thumbs.db] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.690651, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [Thumbs.db] -> [/home/vol1/shares/aclshare/Thumbs.db]
>[2010/04/02 15:04:29.690683,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: Thumbs.db reduced to /home/vol1/shares/aclshare/Thumbs.db
>[2010/04/02 15:04:29.690705,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(Thumbs.db) returning 0660
>[2010/04/02 15:04:29.690724,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [Thumbs.db] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.690761, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [Thumbs.db] -> [/home/vol1/shares/aclshare/Thumbs.db]
>[2010/04/02 15:04:29.690779,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: Thumbs.db reduced to /home/vol1/shares/aclshare/Thumbs.db
>[2010/04/02 15:04:29.690799,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/error.c(160) cmd=162 (SMBntcreateX) NT_STATUS_OBJECT_NAME_NOT_FOUND
>[2010/04/02 15:04:29.692684,  3] smbd/process.c:1485(process_smb)
>  Transaction 321 of length 128 (0 toread)
>[2010/04/02 15:04:29.692721,  3] smbd/process.c:1294(switch_message)
>  switch message SMBntcreateX (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.692748,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.692786, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.692804,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.692822,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.692844, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.692861,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.692887,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(file-with-acls.txt) returning 0660
>[2010/04/02 15:04:29.692905,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.692926, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.692943,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.692987, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.693021, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.693052, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.693069, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.693086, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.693102, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.693118, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.693148, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.693168, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.693184, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.693201, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.693217, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.693233, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.693249, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.693265, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.693281, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.693315, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.693374, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.693798, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.694271, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.694291, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.694307, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.694346,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.694380,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.694398,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.694493,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.694550,  2] smbd/open.c:631(open_file)
>  leerling1 opened file file-with-acls.txt read=No write=No (numopen=1)
>[2010/04/02 15:04:29.694598, 10] smbd/file_access.c:185(can_access_file_data)
>  can_access_file_data: requesting 0x2 on file file-with-acls.txt
>[2010/04/02 15:04:29.694992,  3] smbd/process.c:1485(process_smb)
>  Transaction 322 of length 88 (0 toread)
>[2010/04/02 15:04:29.695014,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.695048,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x4
>[2010/04/02 15:04:29.695067, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.695084, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.695100, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.695130, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.695148, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.695165, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.695270, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.695288, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.695304, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.695324, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.695340, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.695364, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.695393, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.695412, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.695429, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.695445, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.695463, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.695486, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.695544, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.696044, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.696503, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.696523, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.696557, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.696580,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.696614,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.696633,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.696723,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.696776,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 120.
>[2010/04/02 15:04:29.696812,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(240) cmd=160 (SMBnttrans) NT_STATUS_BUFFER_TOO_SMALL
>[2010/04/02 15:04:29.697266,  3] smbd/process.c:1485(process_smb)
>  Transaction 323 of length 88 (0 toread)
>[2010/04/02 15:04:29.697290,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.697310,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x4
>[2010/04/02 15:04:29.697329, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.697346, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.697364, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.697394, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.697413, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.697444, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.697461, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.697477, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.697512, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.697546, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.697564, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.697595, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.697612, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.697641, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.697658, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.697675, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.697692, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.697731, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.697798, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.698223, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.698730, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.698751, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.698776, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.698804,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.698827,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.698844,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.698880,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.698951,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 120.
>[2010/04/02 15:04:29.699571,  3] smbd/process.c:1485(process_smb)
>  Transaction 324 of length 92 (0 toread)
>[2010/04/02 15:04:29.699595,  3] smbd/process.c:1294(switch_message)
>  switch message SMBntcreateX (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.699620,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.699655, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [.] -> [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.699674,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /home/vol1/shares/aclshare
>[2010/04/02 15:04:29.699693,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.699732, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [.] -> [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.699750,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /home/vol1/shares/aclshare
>[2010/04/02 15:04:29.699777,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.699826,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.699846, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [.] -> [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.699864,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /home/vol1/shares/aclshare
>[2010/04/02 15:04:29.699893, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.699911, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.699958, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.699981, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.699998, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.700021, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.700094, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.700165, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.700281, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.700300, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.700318, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.700340,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.700369,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.700387,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.700420,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.700439, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.700463,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.700497,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.700514, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.700538, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.700556, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.700587, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.700615, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.700639, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.700669, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.700702, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.700720, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.700747, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.700804, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.700850, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.700980, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.700999, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.701023, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.701047,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.701068,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.701085,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.701117,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.701137, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.701160,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.701178,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.701195, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.701214, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.701231, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.701261, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.701600,  3] smbd/process.c:1485(process_smb)
>  Transaction 325 of length 76 (0 toread)
>[2010/04/02 15:04:29.701624,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtrans2 (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.701645,  3] smbd/trans2.c:4996(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1006
>[2010/04/02 15:04:29.701672,  3] smbd/trans2.c:5209(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo . (fnum = 7690) level=1006 call=7 total_data=0
>[2010/04/02 15:04:29.702021,  3] smbd/process.c:1485(process_smb)
>  Transaction 326 of length 88 (0 toread)
>[2010/04/02 15:04:29.702044,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.702064,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = ., info_wanted = 0x4
>[2010/04/02 15:04:29.702084, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.702101, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file .
>[2010/04/02 15:04:29.702130, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.702181, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.702203, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.702220, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.702249, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.702322, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.702367, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.702469, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.702503, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.702521, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.702549,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.702572,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.702589,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.702621,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.702660, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.702693,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.702732,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.702749, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.702767, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.702785, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.702802, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.702819,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 168.
>[2010/04/02 15:04:29.702837,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(240) cmd=160 (SMBnttrans) NT_STATUS_BUFFER_TOO_SMALL
>[2010/04/02 15:04:29.703149,  3] smbd/process.c:1485(process_smb)
>  Transaction 327 of length 88 (0 toread)
>[2010/04/02 15:04:29.703172,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.703192,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = ., info_wanted = 0x4
>[2010/04/02 15:04:29.703210, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.703228, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file .
>[2010/04/02 15:04:29.703245, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.703298, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.703321, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.703339, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.703362, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.703419, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.703478, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.703627, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.703646, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.703664, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.703686,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.703722,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.703740,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.703772,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.703791, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.703810,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.703828,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.703845, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.703870, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.703887, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.703904, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.703984,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 168.
>[2010/04/02 15:04:29.704488,  3] smbd/process.c:1485(process_smb)
>  Transaction 328 of length 45 (0 toread)
>[2010/04/02 15:04:29.704527,  3] smbd/process.c:1294(switch_message)
>  switch message SMBclose (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.704547,  3] smbd/reply.c:4624(reply_close)
>  close directory fnum=7690
>[2010/04/02 15:04:29.704943,  3] smbd/process.c:1485(process_smb)
>  Transaction 329 of length 88 (0 toread)
>[2010/04/02 15:04:29.704973,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.704993,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x7
>[2010/04/02 15:04:29.705013, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.705042, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.705060, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.705105, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.705124, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.705155, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.705173, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.705246, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.705266, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.705286, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.705303, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.705336, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.705354, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.705371, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.705387, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.705404, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.705420, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.705443, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.705509, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.706039, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.706527, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.706547, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.706565, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.706588,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.706616,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.706634,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.706669,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.706715,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 176.
>[2010/04/02 15:04:29.706747,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(240) cmd=160 (SMBnttrans) NT_STATUS_BUFFER_TOO_SMALL
>[2010/04/02 15:04:29.707061,  3] smbd/process.c:1485(process_smb)
>  Transaction 330 of length 88 (0 toread)
>[2010/04/02 15:04:29.707085,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.707105,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x7
>[2010/04/02 15:04:29.707125, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.707142, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.707178, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.707209, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.707228, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.707261, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.707278, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.707358, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.707378, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.707399, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.707416, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.707449, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.707466, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.707483, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.707500, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.707516, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.707533, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.707569, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.707642, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.708150, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.708612, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.708632, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.708666, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.708689,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.708712,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.708729,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.708793,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.708851,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 176.
>[2010/04/02 15:04:29.709529,  3] smbd/process.c:1485(process_smb)
>  Transaction 331 of length 76 (0 toread)
>[2010/04/02 15:04:29.709555,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtrans2 (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.709577,  3] smbd/trans2.c:4996(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1004
>[2010/04/02 15:04:29.709607,  3] smbd/trans2.c:5209(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo file-with-acls.txt (fnum = 7688) level=1004 call=7 total_data=0
>[2010/04/02 15:04:29.710074,  3] smbd/process.c:1485(process_smb)
>  Transaction 332 of length 45 (0 toread)
>[2010/04/02 15:04:29.710097,  3] smbd/process.c:1294(switch_message)
>  switch message SMBclose (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.710117,  3] smbd/reply.c:4634(reply_close)
>  close fd=-1 fnum=7688 (numopen=1)
>[2010/04/02 15:04:29.710149,  2] smbd/close.c:656(close_normal_file)
>  leerling1 closed file file-with-acls.txt (numopen=0) NT_STATUS_OK
>[2010/04/02 15:04:29.713917,  3] smbd/process.c:1485(process_smb)
>  Transaction 333 of length 128 (0 toread)
>[2010/04/02 15:04:29.713944,  3] smbd/process.c:1294(switch_message)
>  switch message SMBntcreateX (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.713981,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.714013, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.714033,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.714052,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.714177, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.714212,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.714236,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(file-with-acls.txt) returning 0660
>[2010/04/02 15:04:29.714255,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [file-with-acls.txt] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.714278, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [file-with-acls.txt] -> [/home/vol1/shares/aclshare/file-with-acls.txt]
>[2010/04/02 15:04:29.714296,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: file-with-acls.txt reduced to /home/vol1/shares/aclshare/file-with-acls.txt
>[2010/04/02 15:04:29.714324, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.714342, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.714383, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.714416, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.714435, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.714451, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.714482, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.714505, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.714538, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.714558, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.714591, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.714609, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.714640, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.714657, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.714688, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.714706, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.714729, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.714807, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.715247, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.715711, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.715733, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.715756, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.715782,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.715804,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.715821,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.715874,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.715923,  2] smbd/open.c:631(open_file)
>  leerling1 opened file file-with-acls.txt read=No write=No (numopen=1)
>[2010/04/02 15:04:29.715969, 10] smbd/file_access.c:185(can_access_file_data)
>  can_access_file_data: requesting 0x2 on file file-with-acls.txt
>[2010/04/02 15:04:29.716380,  3] smbd/process.c:1485(process_smb)
>  Transaction 334 of length 88 (0 toread)
>[2010/04/02 15:04:29.716405,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.716439,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x4
>[2010/04/02 15:04:29.716459, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.716496, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.716514, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.716545, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.716578, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.716608, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.716631, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.716648, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.716665, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.716684, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.716716, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.716740, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.716757, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.716774, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.716790, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.716807, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.716824, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.716861, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.716926, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.717367, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.717836, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.717856, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.717873, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.717896,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.717919,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.717949,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.717985,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.718030,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 120.
>[2010/04/02 15:04:29.718050,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(240) cmd=160 (SMBnttrans) NT_STATUS_BUFFER_TOO_SMALL
>[2010/04/02 15:04:29.718439,  3] smbd/process.c:1485(process_smb)
>  Transaction 335 of length 88 (0 toread)
>[2010/04/02 15:04:29.718465,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.718485,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x4
>[2010/04/02 15:04:29.718505, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.718595, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.718617, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.718648, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.718667, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.718685, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.718709, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.718726, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.718743, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.718763, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.718780, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.718797, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.718814, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.718881, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.718902, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.718919, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.718936, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.718959, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.719038, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.719437, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.719903, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.719923, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.719941, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.719964,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.719994,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.720012,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.720049,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.720108,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 120.
>[2010/04/02 15:04:29.720616,  3] smbd/process.c:1485(process_smb)
>  Transaction 336 of length 92 (0 toread)
>[2010/04/02 15:04:29.720641,  3] smbd/process.c:1294(switch_message)
>  switch message SMBntcreateX (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.720679,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.720701, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [.] -> [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.720719,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /home/vol1/shares/aclshare
>[2010/04/02 15:04:29.720737,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.720764, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [.] -> [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.720781,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /home/vol1/shares/aclshare
>[2010/04/02 15:04:29.720803,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.720821,  3] smbd/vfs.c:851(check_reduced_name)
>  check_reduced_name [.] [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.720840, 10] smbd/vfs.c:938(check_reduced_name)
>  check_reduced_name realpath [.] -> [/home/vol1/shares/aclshare]
>[2010/04/02 15:04:29.720857,  3] smbd/vfs.c:1008(check_reduced_name)
>  check_reduced_name: . reduced to /home/vol1/shares/aclshare
>[2010/04/02 15:04:29.720885, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.720903, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.720959, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.720995, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.721012, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.721036, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.721109, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.721154, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.721271, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.721290, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.721307, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.721343,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.721366,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.721383,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.721415,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.721435, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.721473,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.721497,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.721514, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.721543, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.721561, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.721578, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.721605, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.721623, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.721667, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.721689, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.721707, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.721730, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.721801, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.721847, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.721964, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.721983, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.722000, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.722032,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.722052,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.722070,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.722101,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.722121, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.722144,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.722162,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.722194, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.722213, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.722231, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.722248, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.722773,  3] smbd/process.c:1485(process_smb)
>  Transaction 337 of length 88 (0 toread)
>[2010/04/02 15:04:29.722798,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.722818,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = ., info_wanted = 0x4
>[2010/04/02 15:04:29.722848, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.722866, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file .
>[2010/04/02 15:04:29.722883, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.722913, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.722934, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.722952, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.722975, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.723048, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.723094, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.723276, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.723304, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.723321, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.723343,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.723366,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.723383,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.723416,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.723450, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.723469,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.723487,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.723504, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.723522, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.723559, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.723576, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.723594,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 168.
>[2010/04/02 15:04:29.723612,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(240) cmd=160 (SMBnttrans) NT_STATUS_BUFFER_TOO_SMALL
>[2010/04/02 15:04:29.724012,  3] smbd/process.c:1485(process_smb)
>  Transaction 338 of length 88 (0 toread)
>[2010/04/02 15:04:29.724034,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.724054,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = ., info_wanted = 0x4
>[2010/04/02 15:04:29.724180, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=.
>[2010/04/02 15:04:29.724200, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file .
>[2010/04/02 15:04:29.724217, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file .
>[2010/04/02 15:04:29.724261, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 4294967295 for file .
>[2010/04/02 15:04:29.724284, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.724302, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.724325, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.724390, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.724434, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-0 uid 0 (root) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.724542, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.724561, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.724578, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.724613,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.724637,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.724654,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.724744,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.724766, 10] ./modules/vfs_acl_common.c:289(get_nt_acl_internal)
>  get_nt_acl_internal: get_acl_blob returned NT_STATUS_NOT_FOUND
>[2010/04/02 15:04:29.724801,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0770
>[2010/04/02 15:04:29.724820,  3] smbd/dosmode.c:166(unix_mode)
>  unix_mode(.) returning 0660
>[2010/04/02 15:04:29.724837, 10] ./modules/vfs_acl_common.c:200(add_directory_inheritable_components)
>  add_directory_inheritable_components: directory ., mode = 0770
>[2010/04/02 15:04:29.724855, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.724872, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.724889, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.724907,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 168.
>[2010/04/02 15:04:29.725344,  3] smbd/process.c:1485(process_smb)
>  Transaction 339 of length 45 (0 toread)
>[2010/04/02 15:04:29.725369,  3] smbd/process.c:1294(switch_message)
>  switch message SMBclose (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.725390,  3] smbd/reply.c:4624(reply_close)
>  close directory fnum=7693
>[2010/04/02 15:04:29.725759,  3] smbd/process.c:1485(process_smb)
>  Transaction 340 of length 88 (0 toread)
>[2010/04/02 15:04:29.725782,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.725815,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x7
>[2010/04/02 15:04:29.725851, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.725869, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.725886, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.725918, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.725937, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.725955, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.725986, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.726004, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.726075, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.726095, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.726113, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.726134, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.726151, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.726169, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.726185, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.726201, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.726218, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.726255, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.726316, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.726848, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.727338, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.727358, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.727392, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.727416,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.727439,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.727456,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.727491,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.727565,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 176.
>[2010/04/02 15:04:29.727586,  3] smbd/error.c:80(error_packet_set)
>  error packet at smbd/nttrans.c(240) cmd=160 (SMBnttrans) NT_STATUS_BUFFER_TOO_SMALL
>[2010/04/02 15:04:29.727931,  3] smbd/process.c:1485(process_smb)
>  Transaction 341 of length 88 (0 toread)
>[2010/04/02 15:04:29.727968,  3] smbd/process.c:1294(switch_message)
>  switch message SMBnttrans (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.727989,  3] smbd/nttrans.c:1786(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: file = file-with-acls.txt, info_wanted = 0x7
>[2010/04/02 15:04:29.728009, 10] ./modules/vfs_acl_common.c:262(get_nt_acl_internal)
>  get_nt_acl_internal: name=file-with-acls.txt
>[2010/04/02 15:04:29.728026, 10] smbd/posix_acls.c:3443(posix_fget_nt_acl)
>  posix_fget_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.728043, 10] smbd/posix_acls.c:3477(posix_get_nt_acl)
>  posix_get_nt_acl: called for file file-with-acls.txt
>[2010/04/02 15:04:29.728095, 10] smbd/posix_acls.c:712(load_inherited_info)
>  load_inherited_info: ret = 25 for file file-with-acls.txt
>[2010/04/02 15:04:29.728179, 10] smbd/posix_acls.c:564(create_pai_val_v2)
>  create_pai_val_v2: sd_type = 0x8004 num_entries = 3, num_def_entries = 0
>[2010/04/02 15:04:29.728198, 10] smbd/posix_acls.c:417(get_pai_owner_type)
>  get_pai_owner_type: world ace
>[2010/04/02 15:04:29.728215, 10] smbd/posix_acls.c:408(get_pai_owner_type)
>  get_pai_owner_type: uid = 6683
>[2010/04/02 15:04:29.728231, 10] smbd/posix_acls.c:413(get_pai_owner_type)
>  get_pai_owner_type: gid = 100
>[2010/04/02 15:04:29.728248, 10] smbd/posix_acls.c:732(load_inherited_info)
>  load_inherited_info: ACL type 0x8004 for file file-with-acls.txt
>[2010/04/02 15:04:29.728268, 10] smbd/posix_acls.c:158(get_entry_val)
>  get_entry_val: uid = 6683
>[2010/04/02 15:04:29.728285, 10] smbd/posix_acls.c:138(get_pai_entry_val)
>  get_pai_entry_val: uid = 6683
>[2010/04/02 15:04:29.728310, 10] smbd/posix_acls.c:161(get_entry_val)
>  get_entry_val: gid = 100
>[2010/04/02 15:04:29.728327, 10] smbd/posix_acls.c:141(get_pai_entry_val)
>  get_pai_entry_val: gid = 100
>[2010/04/02 15:04:29.728359, 10] smbd/posix_acls.c:165(get_entry_val)
>  get_entry_val: world ace
>[2010/04/02 15:04:29.728376, 10] smbd/posix_acls.c:145(get_pai_entry_val)
>  get_pai_entry_val: world ace
>[2010/04/02 15:04:29.728393, 10] smbd/posix_acls.c:2605(canonicalise_acl)
>  canonicalise_acl: Access ace entries before arrange :
>[2010/04/02 15:04:29.728410, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.728432, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.728503, 10] smbd/posix_acls.c:2618(canonicalise_acl)
>  canon_ace index 2. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>[2010/04/02 15:04:29.729022, 10] smbd/posix_acls.c:841(print_canon_ace_list)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-14366 uid 6683 (leerling1) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 1. Type = allow SID = S-1-5-21-2680263629-3535859742-3145682158-100 gid 100 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms ---
>[2010/04/02 15:04:29.729519, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.729539, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2010/04/02 15:04:29.729557, 10] smbd/posix_acls.c:1117(map_canon_ace_perms)
>  map_canon_ace_perms: Mapped (UNIX) 0 to (NT) 0
>[2010/04/02 15:04:29.729654,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(6683, 100) : sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.729678,  3] smbd/uid.c:429(push_conn_ctx)
>  push_conn_ctx(101) : conn_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.729696,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2010/04/02 15:04:29.729798,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (6683, 100) - sec_ctx_stack_ndx = 0
>[2010/04/02 15:04:29.729851,  3] smbd/nttrans.c:1820(call_nt_transact_query_security_desc)
>  call_nt_transact_query_security_desc: sd_size = 176.
>[2010/04/02 15:04:29.730275,  3] smbd/process.c:1485(process_smb)
>  Transaction 342 of length 76 (0 toread)
>[2010/04/02 15:04:29.730303,  3] smbd/process.c:1294(switch_message)
>  switch message SMBtrans2 (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.730325,  3] smbd/trans2.c:4996(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1004
>[2010/04/02 15:04:29.730356,  3] smbd/trans2.c:5209(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo file-with-acls.txt (fnum = 7691) level=1004 call=7 total_data=0
>[2010/04/02 15:04:29.730862,  3] smbd/process.c:1485(process_smb)
>  Transaction 343 of length 45 (0 toread)
>[2010/04/02 15:04:29.730885,  3] smbd/process.c:1294(switch_message)
>  switch message SMBclose (pid 27822) conn 0xb8e03230
>[2010/04/02 15:04:29.730904,  3] smbd/reply.c:4634(reply_close)
>  close fd=-1 fnum=7691 (numopen=1)
>[2010/04/02 15:04:29.730965,  2] smbd/close.c:656(close_normal_file)
>  leerling1 closed file file-with-acls.txt (numopen=0) NT_STATUS_OK

Actions: View

Attachments on bug 6917: 5588 | 5589 | 5590