[2005/10/04 11:50:12, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 71 [2005/10/04 11:50:12, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x47 [2005/10/04 11:50:12, 3] smbd/process.c:process_smb(1114) Transaction 25 of length 75 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=71 smb_com=0x81 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25601 smt_wct=2 smb_vwv[ 0]= 20 (0x14) smb_vwv[ 1]= 8 (0x8) smb_bcc=32 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 04 5C 00 3E 00 3E 00 3E 00 3E 00 3E 00 3E 00 3E .\.>.>.> .>.>.>.> [010] 00 3E 00 22 00 3E 00 3E 00 3E 00 00 00 05 00 00 .>.".>.> .>...... [2005/10/04 11:50:12, 3] smbd/process.c:switch_message(900) switch message SMBsearch (pid 28332) conn 0x82ef828 [2005/10/04 11:50:12, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (1009, 1012) - sec_ctx_stack_ndx = 0 [2005/10/04 11:50:12, 5] auth/auth_util.c:debug_nt_user_token(457) NT user token of user S-1-5-21-2855599581-4132206758-812185842-3018 contains 5 SIDs SID[ 0]: S-1-5-21-2855599581-4132206758-812185842-3018 SID[ 1]: S-1-5-21-2855599581-4132206758-812185842-3025 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SE_PRIV 0x0 0x0 0x0 0x0 [2005/10/04 11:50:12, 5] auth/auth_util.c:debug_unix_user_token(473) UNIX token of user 1009 Primary group is 1012 and contains 1 supplementary groups Group[ 0]: 1012 [2005/10/04 11:50:12, 5] smbd/uid.c:change_to_user(304) change_to_user uid=(1009,1009) gid=(0,1012) [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(108) unix_convert called on file ">>>>>>>>">>>" [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(215) stat_cache_lookup: lookup failed for name [>>>>>>>>">>>] [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(175) unix_convert begin: name = >>>>>>>>">>>, dirpath = , start = >>>>>>>>">>> [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled(276) is_mangled >>>>>>>>">>> ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component >>>>>>>>">>> (len 12) ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled(276) is_mangled >>>>>>>>">>> ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component >>>>>>>>">>> (len 12) ? [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(324) New file >>>>>>>>">>> [2005/10/04 11:50:12, 5] smbd/dir.c:dptr_create(391) dptr_create dir=. [2005/10/04 11:50:12, 3] smbd/dir.c:dptr_create(511) creating new dirptr 2 for path ., expect_close = 0 [2005/10/04 11:50:12, 4] smbd/reply.c:reply_search(1131) dptr_num is 2 [2005/10/04 11:50:12, 8] smbd/dir.c:make_dir_struct(103) put name [SHARE] from [share] into dir struct [2005/10/04 11:50:12, 6] smbd/dir.c:dptr_fill(662) fill on key 2 dirptr 0x82f00a0 now at 0 [2005/10/04 11:50:12, 4] smbd/reply.c:reply_search(1215) SMBsearch mask=>>>>>>>>">>> path=. dtype=8 nument=1 of 20 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=83 smb_com=0x81 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=0 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25601 smt_wct=1 smb_vwv[ 0]= 1 (0x1) smb_bcc=46 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 05 2B 00 08 3F 3F 3F 3F 3F 3F 3F 3F 3F 3F 3F 02 .+..???? ???????. [010] 00 00 00 00 00 00 00 00 08 00 38 21 EC 00 00 00 ........ ..8!.... [020] 00 53 48 41 52 45 00 00 00 00 00 00 00 00 .SHARE.. ...... [2005/10/04 11:50:12, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 67 [2005/10/04 11:50:12, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x43 [2005/10/04 11:50:12, 3] smbd/process.c:process_smb(1114) Transaction 26 of length 71 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=67 smb_com=0x81 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25729 smt_wct=2 smb_vwv[ 0]= 20 (0x14) smb_vwv[ 1]= 0 (0x0) smb_bcc=28 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 04 5C 00 31 00 5C 00 54 00 45 00 53 00 54 00 22 .\.1.\.T .E.S.T." [010] 00 54 00 58 00 54 00 00 00 05 00 00 .T.X.T.. .... [2005/10/04 11:50:12, 3] smbd/process.c:switch_message(900) switch message SMBsearch (pid 28332) conn 0x82ef828 [2005/10/04 11:50:12, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "1/TEST"TXT" [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(215) stat_cache_lookup: lookup failed for name [1/TEST"TXT] [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(215) stat_cache_lookup: lookup failed for name [1] [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(175) unix_convert begin: name = 1/TEST"TXT, dirpath = , start = 1/TEST"TXT [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled(276) is_mangled 1/TEST"TXT ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component 1/TEST"TXT (len 1) ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component TEST"TXT (len 8) ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled(276) is_mangled TEST"TXT ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component TEST"TXT (len 8) ? [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(324) New file TEST"TXT [2005/10/04 11:50:12, 5] smbd/dir.c:dptr_create(391) dptr_create dir=1 [2005/10/04 11:50:12, 3] smbd/dir.c:dptr_create(511) creating new dirptr 3 for path 1, expect_close = 0 [2005/10/04 11:50:12, 4] smbd/reply.c:reply_search(1131) dptr_num is 3 [2005/10/04 11:50:12, 8] smbd/reply.c:reply_search(1149) dirpath=<1> dontdescend=<> [2005/10/04 11:50:12, 6] smbd/dir.c:get_dir_entry(771) readdir on dirptr 0x82c8200 now at offset 0 [2005/10/04 11:50:12, 6] smbd/dir.c:get_dir_entry(771) readdir on dirptr 0x82c8200 now at offset -2147483648 [2005/10/04 11:50:12, 6] smbd/dir.c:get_dir_entry(771) readdir on dirptr 0x82c8200 now at offset 1 [2005/10/04 11:50:12, 8] smbd/dosmode.c:dos_mode(294) dos_mode: 1/test.txt [2005/10/04 11:50:12, 10] smbd/dosmode.c:get_ea_dos_attribute(203) get_ea_dos_attribute: 1/test.txt attrstr = 0x20 [2005/10/04 11:50:12, 8] smbd/dosmode.c:get_ea_dos_attribute(216) get_ea_dos_attribute returning (0x20)a [2005/10/04 11:50:12, 8] smbd/dosmode.c:dos_mode(328) dos_mode returning a [2005/10/04 11:50:12, 3] smbd/dir.c:get_dir_entry(812) get_dir_entry mask=[TEST"TXT] found 1/test.txt fname=test.txt [2005/10/04 11:50:12, 8] smbd/dir.c:make_dir_struct(103) put name [TEST.TXT] from [test.txt] into dir struct [2005/10/04 11:50:12, 6] smbd/dir.c:dptr_fill(662) fill on key 3 dirptr 0x82f00e0 now at 1 [2005/10/04 11:50:12, 6] smbd/dir.c:get_dir_entry(771) readdir on dirptr 0x82c8200 now at offset 2 [2005/10/04 11:50:12, 6] smbd/dir.c:get_dir_entry(771) readdir on dirptr 0x82c8200 now at offset -1 [2005/10/04 11:50:12, 4] smbd/reply.c:reply_search(1215) SMBsearch mask=TEST"TXT path=1 dtype=0 nument=1 of 20 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=83 smb_com=0x81 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=0 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25729 smt_wct=1 smb_vwv[ 0]= 1 (0x1) smb_bcc=46 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 05 2B 00 00 54 45 53 54 22 54 58 54 20 20 20 03 .+..TEST "TXT . [010] 01 00 00 00 00 00 00 00 20 B5 4A 44 33 00 00 00 ........ .JD3... [020] 00 54 45 53 54 2E 54 58 54 00 00 00 00 00 .TEST.TX T..... [2005/10/04 11:50:12, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 60 [2005/10/04 11:50:12, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x3c [2005/10/04 11:50:12, 3] smbd/process.c:process_smb(1114) Transaction 27 of length 64 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=60 smb_com=0x10 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25857 smt_wct=0 smb_bcc=25 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 04 5C 00 31 00 5C 00 54 00 45 00 53 00 54 00 2E .\.1.\.T .E.S.T.. [010] 00 54 00 58 00 54 00 00 00 .T.X.T.. . [2005/10/04 11:50:12, 3] smbd/process.c:switch_message(900) switch message SMBchkpth (pid 28332) conn 0x82ef828 [2005/10/04 11:50:12, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "1/TEST.TXT" [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(215) stat_cache_lookup: lookup failed for name [1/TEST.TXT] [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(215) stat_cache_lookup: lookup failed for name [1] [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(175) unix_convert begin: name = 1/TEST.TXT, dirpath = , start = 1/TEST.TXT [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled(276) is_mangled 1/TEST.TXT ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component 1/TEST.TXT (len 1) ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component TEST.TXT (len 8) ? [2005/10/04 11:50:12, 5] smbd/statcache.c:stat_cache_add(140) stat_cache_add: Added entry (82ea6f0:size2) 1 -> 1 [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled(276) is_mangled TEST.TXT ? [2005/10/04 11:50:12, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component TEST.TXT (len 8) ? [2005/10/04 11:50:12, 5] smbd/statcache.c:stat_cache_add(140) stat_cache_add: Added entry (82ea6f0:sizeb) 1/TEST.TXT -> 1/test.txt [2005/10/04 11:50:12, 5] smbd/statcache.c:stat_cache_add(140) stat_cache_add: Added entry (82ea6f0:sizeb) 1/TEST.TXT -> 1/test.txt [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(389) conversion finished 1/TEST.TXT -> 1/test.txt [2005/10/04 11:50:12, 3] smbd/error.c:error_packet(163) error packet at smbd/reply.c(776) cmd=16 (SMBchkpth) eclass=1 ecode=3 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=35 smb_com=0x10 smb_rcls=1 smb_reh=0 smb_err=3 smb_flg=128 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25857 smt_wct=0 smb_bcc=0 [2005/10/04 11:50:12, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 42 [2005/10/04 11:50:12, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x2a [2005/10/04 11:50:12, 3] smbd/process.c:process_smb(1114) Transaction 28 of length 46 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=42 smb_com=0x10 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25985 smt_wct=0 smb_bcc=7 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 04 5C 00 31 00 00 00 .\.1... [2005/10/04 11:50:12, 3] smbd/process.c:switch_message(900) switch message SMBchkpth (pid 28332) conn 0x82ef828 [2005/10/04 11:50:12, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "1" [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(248) stat_cache_lookup: lookup succeeded for name [1] -> [1] [2005/10/04 11:50:12, 3] smbd/reply.c:reply_chkpth(804) chkpth 1 mode=7 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=35 smb_com=0x10 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=25985 smt_wct=0 smb_bcc=0 [2005/10/04 11:50:12, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 84 [2005/10/04 11:50:12, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x54 [2005/10/04 11:50:12, 3] smbd/process.c:process_smb(1114) Transaction 29 of length 88 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=84 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26113 smt_wct=15 smb_vwv[ 0]= 18 (0x12) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 10 (0xA) smb_vwv[ 3]= 616 (0x268) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 18 (0x12) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 1 (0x1) smb_bcc=19 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 00 16 00 01 00 01 00 04 01 00 00 00 00 5C 00 31 ........ .....\.1 [010] 00 00 00 ... [2005/10/04 11:50:12, 3] smbd/process.c:switch_message(900) switch message SMBtrans2 (pid 28332) conn 0x82ef828 [2005/10/04 11:50:12, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:12, 3] smbd/trans2.c:call_trans2findfirst(1629) call_trans2findfirst: dirtype = 16, maxentries = 1, close_after_first=1, close_if_end = 0 requires_resume_key = 0 level = 0x104, max_data_bytes = 616 [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "1" [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(248) stat_cache_lookup: lookup succeeded for name [1] -> [1] [2005/10/04 11:50:12, 5] smbd/trans2.c:call_trans2findfirst(1683) dir=./, mask = 1 [2005/10/04 11:50:12, 5] smbd/dir.c:dptr_create(391) dptr_create dir=./ [2005/10/04 11:50:12, 3] smbd/dir.c:dptr_create(511) creating new dirptr 256 for path ./, expect_close = 1 [2005/10/04 11:50:12, 4] smbd/trans2.c:call_trans2findfirst(1740) dptr_num is 256, wcard = 1, attr = 22 [2005/10/04 11:50:12, 8] smbd/trans2.c:call_trans2findfirst(1745) dirpath=<./> dontdescend=<> [2005/10/04 11:50:12, 8] smbd/trans2.c:get_lanman2_dir_entry(1077) get_lanman2_dir_entry:readdir on dirptr 0x82d0040 now at offset -1 [2005/10/04 11:50:12, 8] smbd/dosmode.c:dos_mode(294) dos_mode: ./1 [2005/10/04 11:50:12, 10] smbd/posix_acls.c:check_posix_acl_group_write(4048) check_posix_acl_group_write: ret = -1 before check_stat: [2005/10/04 11:50:12, 10] smbd/posix_acls.c:check_posix_acl_group_write(4069) check_posix_acl_group_write: file ./1 failed to match on user or group in token (ret = -1). [2005/10/04 11:50:12, 10] smbd/posix_acls.c:check_posix_acl_group_write(4078) check_posix_acl_group_write: file ./1 returning (ret = -1). [2005/10/04 11:50:12, 8] smbd/dosmode.c:dos_mode_from_sbuf(162) dos_mode_from_sbuf returning rd [2005/10/04 11:50:12, 8] smbd/dosmode.c:dos_mode(328) dos_mode returning rd [2005/10/04 11:50:12, 5] smbd/trans2.c:get_lanman2_dir_entry(1167) get_lanman2_dir_entry found ./1 fname=1 [2005/10/04 11:50:12, 10] smbd/trans2.c:get_lanman2_dir_entry(1308) get_lanman2_dir_entry: SMB_FIND_FILE_BOTH_DIRECTORY_INFO [2005/10/04 11:50:12, 5] smbd/trans2.c:call_trans2findfirst(1793) call_trans2findfirst - (2) closing dptr_num 256 [2005/10/04 11:50:12, 4] smbd/dir.c:dptr_close_internal(238) closing dptr key 256 [2005/10/04 11:50:12, 9] smbd/trans2.c:send_trans2_replies(685) t2_rep: params_sent_thistime = 10, data_sent_thistime = 96, useable_space = 2858 [2005/10/04 11:50:12, 9] smbd/trans2.c:send_trans2_replies(687) t2_rep: params_to_send = 10, data_to_send = 96, paramsize = 10, datasize = 96 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=164 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32833 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26113 smt_wct=10 smb_vwv[ 0]= 10 (0xA) smb_vwv[ 1]= 96 (0x60) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 10 (0xA) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 96 (0x60) smb_vwv[ 7]= 68 (0x44) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=109 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 00 FD FF 01 00 01 00 00 00 00 00 00 00 60 00 00 ........ .....`.. [010] 00 00 00 00 00 80 EF 2E DC 8B C8 C5 01 00 DA 81 ........ ........ [020] 1A 9F C8 C5 01 80 EF 2E DC 8B C8 C5 01 80 EF 2E ........ ........ [030] DC 8B C8 C5 01 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [040] 00 00 00 00 00 11 00 00 00 02 00 00 00 00 00 00 ........ ........ [050] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [060] 00 00 00 00 00 00 00 00 00 00 00 31 00 ........ ...1. [2005/10/04 11:50:12, 4] smbd/trans2.c:call_trans2findfirst(1829) SMBtrans2 mask=1 directory=./ dirtype=22 numentries=1 [2005/10/04 11:50:12, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 102 [2005/10/04 11:50:12, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x66 [2005/10/04 11:50:12, 3] smbd/process.c:process_smb(1114) Transaction 30 of length 106 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=102 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26241 smt_wct=15 smb_vwv[ 0]= 36 (0x24) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 10 (0xA) smb_vwv[ 3]= 2432 (0x980) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 36 (0x24) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 1 (0x1) smb_bcc=37 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 00 16 00 04 00 00 00 04 01 00 00 00 00 5C 00 31 ........ .....\.1 [010] 00 5C 00 54 00 45 00 53 00 54 00 2E 00 54 00 58 .\.T.E.S .T...T.X [020] 00 54 00 00 00 .T... [2005/10/04 11:50:12, 3] smbd/process.c:switch_message(900) switch message SMBtrans2 (pid 28332) conn 0x82ef828 [2005/10/04 11:50:12, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:12, 3] smbd/trans2.c:call_trans2findfirst(1629) call_trans2findfirst: dirtype = 16, maxentries = 4, close_after_first=0, close_if_end = 0 requires_resume_key = 0 level = 0x104, max_data_bytes = 2432 [2005/10/04 11:50:12, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "1/TEST.TXT" [2005/10/04 11:50:12, 10] smbd/statcache.c:stat_cache_lookup(248) stat_cache_lookup: lookup succeeded for name [1/TEST.TXT] -> [1/test.txt] [2005/10/04 11:50:12, 5] smbd/trans2.c:call_trans2findfirst(1683) dir=1, mask = test.txt [2005/10/04 11:50:12, 5] smbd/dir.c:dptr_create(391) dptr_create dir=1 [2005/10/04 11:50:12, 3] smbd/dir.c:dptr_create(511) creating new dirptr 256 for path 1, expect_close = 1 [2005/10/04 11:50:12, 4] smbd/trans2.c:call_trans2findfirst(1740) dptr_num is 256, wcard = test.txt, attr = 22 [2005/10/04 11:50:12, 8] smbd/trans2.c:call_trans2findfirst(1745) dirpath=<1> dontdescend=<> [2005/10/04 11:50:12, 8] smbd/trans2.c:get_lanman2_dir_entry(1077) get_lanman2_dir_entry:readdir on dirptr 0x82d0040 now at offset -1 [2005/10/04 11:50:12, 8] smbd/dosmode.c:dos_mode(294) dos_mode: 1/test.txt [2005/10/04 11:50:12, 10] smbd/dosmode.c:get_ea_dos_attribute(203) get_ea_dos_attribute: 1/test.txt attrstr = 0x20 [2005/10/04 11:50:12, 8] smbd/dosmode.c:get_ea_dos_attribute(216) get_ea_dos_attribute returning (0x20)a [2005/10/04 11:50:12, 8] smbd/dosmode.c:dos_mode(328) dos_mode returning a [2005/10/04 11:50:12, 5] smbd/trans2.c:get_lanman2_dir_entry(1167) get_lanman2_dir_entry found 1/test.txt fname=test.txt [2005/10/04 11:50:12, 10] smbd/trans2.c:get_lanman2_dir_entry(1308) get_lanman2_dir_entry: SMB_FIND_FILE_BOTH_DIRECTORY_INFO [2005/10/04 11:50:12, 9] smbd/trans2.c:send_trans2_replies(685) t2_rep: params_sent_thistime = 10, data_sent_thistime = 112, useable_space = 2858 [2005/10/04 11:50:12, 9] smbd/trans2.c:send_trans2_replies(687) t2_rep: params_to_send = 10, data_to_send = 112, paramsize = 10, datasize = 112 [2005/10/04 11:50:12, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:12, 5] lib/util.c:show_msg(464) size=180 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32833 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26241 smt_wct=10 smb_vwv[ 0]= 10 (0xA) smb_vwv[ 1]= 112 (0x70) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 10 (0xA) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 112 (0x70) smb_vwv[ 7]= 68 (0x44) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=125 [2005/10/04 11:50:12, 10] lib/util.c:dump_data(2053) [000] 00 00 01 01 00 01 00 00 00 00 00 00 00 70 00 00 ........ .....p.. [010] 00 00 00 00 00 80 55 54 5C 8A C8 C5 01 00 DA 81 ......UT \....... [020] 1A 9F C8 C5 01 80 55 54 5C 8A C8 C5 01 80 55 54 ......UT \.....UT [030] 5C 8A C8 C5 01 00 00 00 00 00 00 00 00 00 00 10 \....... ........ [040] 00 00 00 00 00 20 00 00 00 10 00 00 00 00 00 00 ..... .. ........ [050] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ........ ........ [060] 00 00 00 00 00 00 00 00 00 00 00 74 00 65 00 73 ........ ...t.e.s [070] 00 74 00 2E 00 74 00 78 00 74 00 00 00 .t...t.x .t... [2005/10/04 11:50:12, 4] smbd/trans2.c:call_trans2findfirst(1829) SMBtrans2 mask=test.txt directory=1 dirtype=22 numentries=1 [2005/10/04 11:50:13, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 96 [2005/10/04 11:50:13, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x60 [2005/10/04 11:50:13, 3] smbd/process.c:process_smb(1114) Transaction 31 of length 100 [2005/10/04 11:50:13, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:13, 5] lib/util.c:show_msg(464) size=96 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26369 smt_wct=15 smb_vwv[ 0]= 30 (0x1E) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 8 (0x8) smb_vwv[ 3]= 2432 (0x980) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 30 (0x1E) smb_vwv[10]= 66 (0x42) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 2 (0x2) smb_bcc=31 [2005/10/04 11:50:13, 10] lib/util.c:dump_data(2053) [000] 00 00 01 04 00 04 01 00 00 00 00 00 00 74 00 65 ........ .....t.e [010] 00 73 00 74 00 2E 00 74 00 78 00 74 00 00 00 .s.t...t .x.t... [2005/10/04 11:50:13, 3] smbd/process.c:switch_message(900) switch message SMBtrans2 (pid 28332) conn 0x82ef828 [2005/10/04 11:50:13, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:13, 3] smbd/trans2.c:call_trans2findnext(1909) call_trans2findnext: dirhandle = 256, max_data_bytes = 2432, maxentries = 4, close_after_request=0, close_if_end = 0 requires_resume_key = 0 resume_key = 0 resume name = test.txt continue=0 level = 260 [2005/10/04 11:50:13, 3] smbd/dir.c:dptr_fetch_lanman2(708) fetching dirptr 256 for path 1 [2005/10/04 11:50:13, 3] smbd/trans2.c:call_trans2findnext(2004) dptr_num is 256, mask = test.txt, attr = 16, dirptr=(0x82D0040,-1) [2005/10/04 11:50:13, 8] smbd/trans2.c:call_trans2findnext(2009) dirpath=<1> dontdescend=<> [2005/10/04 11:50:13, 10] smbd/mangle_hash2.c:is_mangled(276) is_mangled test.txt ? [2005/10/04 11:50:13, 10] smbd/mangle_hash2.c:is_mangled_component(215) is_mangled_component test.txt (len 8) ? [2005/10/04 11:50:13, 9] smbd/trans2.c:send_trans2_replies(685) t2_rep: params_sent_thistime = 8, data_sent_thistime = 0, useable_space = 2860 [2005/10/04 11:50:13, 9] smbd/trans2.c:send_trans2_replies(687) t2_rep: params_to_send = 8, data_to_send = 0, paramsize = 8, datasize = 0 [2005/10/04 11:50:13, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:13, 5] lib/util.c:show_msg(464) size=64 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32833 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26369 smt_wct=10 smb_vwv[ 0]= 8 (0x8) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 8 (0x8) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=9 [2005/10/04 11:50:13, 10] lib/util.c:dump_data(2053) [000] 00 00 00 01 00 00 00 00 00 ........ . [2005/10/04 11:50:13, 3] smbd/trans2.c:call_trans2findnext(2105) SMBtrans2 mask=test.txt directory=1 dirtype=22 numentries=0 [2005/10/04 11:50:13, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 37 [2005/10/04 11:50:13, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x25 [2005/10/04 11:50:13, 3] smbd/process.c:process_smb(1114) Transaction 32 of length 41 [2005/10/04 11:50:13, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:13, 5] lib/util.c:show_msg(464) size=37 smb_com=0x34 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26497 smt_wct=1 smb_vwv[ 0]= 256 (0x100) smb_bcc=0 [2005/10/04 11:50:13, 3] smbd/process.c:switch_message(900) switch message SMBfindclose (pid 28332) conn 0x82ef828 [2005/10/04 11:50:13, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:13, 3] smbd/trans2.c:reply_findclose(4786) reply_findclose, dptr_num = 256 [2005/10/04 11:50:13, 4] smbd/dir.c:dptr_close_internal(238) closing dptr key 256 [2005/10/04 11:50:13, 3] smbd/trans2.c:reply_findclose(4792) SMBfindclose dptr_num = -3 [2005/10/04 11:50:13, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:13, 5] lib/util.c:show_msg(464) size=35 smb_com=0x34 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26497 smt_wct=0 smb_bcc=0 [2005/10/04 11:50:13, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 35 [2005/10/04 11:50:13, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x23 [2005/10/04 11:50:13, 3] smbd/process.c:process_smb(1114) Transaction 33 of length 39 [2005/10/04 11:50:13, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:13, 5] lib/util.c:show_msg(464) size=35 smb_com=0x80 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26625 smt_wct=0 smb_bcc=0 [2005/10/04 11:50:13, 3] smbd/process.c:switch_message(900) switch message SMBdskattr (pid 28332) conn 0x82ef828 [2005/10/04 11:50:13, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:13, 3] smbd/reply.c:reply_dskattr(1000) dskattr dfree=16509 [2005/10/04 11:50:13, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:13, 5] lib/util.c:show_msg(464) size=45 smb_com=0x80 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26625 smt_wct=5 smb_vwv[ 0]=33874 (0x8452) smb_vwv[ 1]= 512 (0x200) smb_vwv[ 2]= 512 (0x200) smb_vwv[ 3]=16509 (0x407D) smb_vwv[ 4]= 0 (0x0) smb_bcc=0 [2005/10/04 11:50:23, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 90 [2005/10/04 11:50:23, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x5a [2005/10/04 11:50:23, 3] smbd/process.c:process_smb(1114) Transaction 34 of length 94 [2005/10/04 11:50:23, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:23, 5] lib/util.c:show_msg(464) size=90 smb_com=0x2d smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26753 smt_wct=15 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 7 (0x7) smb_vwv[ 3]= 34 (0x22) smb_vwv[ 4]= 22 (0x16) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]=31374 (0x7A8E) smb_vwv[ 7]=17218 (0x4342) smb_vwv[ 8]= 18 (0x12) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 0 (0x0) smb_vwv[14]= 0 (0x0) smb_bcc=25 [2005/10/04 11:50:23, 10] lib/util.c:dump_data(2053) [000] 00 5C 00 31 00 5C 00 74 00 65 00 73 00 74 00 2E .\.1.\.t .e.s.t.. [010] 00 74 00 78 00 74 00 00 00 .t.x.t.. . [2005/10/04 11:50:23, 3] smbd/process.c:switch_message(900) switch message SMBopenX (pid 28332) conn 0x82ef828 [2005/10/04 11:50:23, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:23, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "1/test.txt" [2005/10/04 11:50:23, 10] smbd/statcache.c:stat_cache_lookup(248) stat_cache_lookup: lookup succeeded for name [1/TEST.TXT] -> [1/test.txt] [2005/10/04 11:50:23, 10] smbd/open.c:map_open_params_to_ntcreate(1045) map_open_params_to_ntcreate: fname = 1/test.txt, deny_mode = 0x22, open_func = 0x12 [2005/10/04 11:50:23, 10] smbd/open.c:map_open_params_to_ntcreate(1148) map_open_params_to_ntcreate: file 1/test.txt, access_mask = 0x12019f, share_mode = 0x1, create_disposition = 0x5, create_options = 0x0 [2005/10/04 11:50:23, 3] smbd/dosmode.c:unix_mode(121) unix_mode(1/test.txt) returning 0744 [2005/10/04 11:50:23, 10] smbd/open.c:open_file_ntcreate(1236) open_file_ntcreate: fname=1/test.txt, dos_attrs=0x0 access_mask=0x12019f share_access=0x1 create_disposition = 0x5 create_options=0x0 unix mode=0744 oplock_request=3 [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(294) dos_mode: 1/test.txt [2005/10/04 11:50:23, 10] smbd/dosmode.c:get_ea_dos_attribute(203) get_ea_dos_attribute: 1/test.txt attrstr = 0x20 [2005/10/04 11:50:23, 8] smbd/dosmode.c:get_ea_dos_attribute(216) get_ea_dos_attribute returning (0x20)a [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(328) dos_mode returning a [2005/10/04 11:50:23, 10] smbd/open.c:open_match_attributes(949) open_match_attributes: file 1/test.txt old_dos_attr = 0x20, existing_unx_mode = 0100644, new_dos_attr = 0x0 returned_unx_mode = 00 [2005/10/04 11:50:23, 10] smbd/open.c:open_file_ntcreate(1409) open_file_ntcreate: fname=1/test.txt, after mapping access_mask=0x12019f [2005/10/04 11:50:23, 5] smbd/files.c:file_new(139) allocated file structure 916, fnum = 5012 (1 used) [2005/10/04 11:50:23, 4] smbd/open.c:open_file_ntcreate(1580) calling open_file with flags=0x2 flags2=0x600 mode=0744 [2005/10/04 11:50:23, 10] smbd/open.c:fd_open(55) fd_open: name 1/test.txt, flags = 01002 mode = 0744, fd = -1. Permission denied [2005/10/04 11:50:23, 3] smbd/open.c:open_file(296) Error opening file 1/test.txt (Permission denied) (local_flags=514) (flags=1538) [2005/10/04 11:50:23, 10] smbd/open.c:fd_open(55) fd_open: name 1/test.txt, flags = 00 mode = 0744, fd = 30. [2005/10/04 11:50:23, 2] smbd/open.c:open_file(372) RC20 opened file 1/test.txt read=Yes write=Yes (numopen=1) [2005/10/04 11:50:23, 10] locking/locking.c:set_share_mode(753) set_share_mode: creating entry for file 1/test.txt. num_share_modes = 1 [2005/10/04 11:50:23, 10] locking/locking.c:print_share_mode_table(463) print_share_mode_table: share_mode_entry[0]: pid = 28332, share_access = 0x1, private_options = 0x0, access_mask = 0x12019f, port = 0x0, type= 0x0, file_id = 1, dev = 0x415, inode = 779539 [2005/10/04 11:50:23, 10] smbd/dosmode.c:file_set_dosmode(353) file_set_dosmode: setting dos mode 0x20 on file 1/test.txt [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(294) dos_mode: 1/test.txt [2005/10/04 11:50:23, 10] smbd/dosmode.c:get_ea_dos_attribute(203) get_ea_dos_attribute: 1/test.txt attrstr = 0x20 [2005/10/04 11:50:23, 8] smbd/dosmode.c:get_ea_dos_attribute(216) get_ea_dos_attribute returning (0x20)a [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(328) dos_mode returning a [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(294) dos_mode: 1/test.txt [2005/10/04 11:50:23, 10] smbd/dosmode.c:get_ea_dos_attribute(203) get_ea_dos_attribute: 1/test.txt attrstr = 0x20 [2005/10/04 11:50:23, 8] smbd/dosmode.c:get_ea_dos_attribute(216) get_ea_dos_attribute returning (0x20)a [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(328) dos_mode returning a [2005/10/04 11:50:23, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:23, 5] lib/util.c:show_msg(464) size=65 smb_com=0x2d smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26753 smt_wct=15 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 5012 (0x1394) smb_vwv[ 3]= 32 (0x20) smb_vwv[ 4]=18855 (0x49A7) smb_vwv[ 5]=17218 (0x4342) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 2 (0x2) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 3 (0x3) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 0 (0x0) smb_vwv[14]= 0 (0x0) smb_bcc=0 [2005/10/04 11:50:23, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 54 [2005/10/04 11:50:23, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x36 [2005/10/04 11:50:23, 3] smbd/process.c:process_smb(1114) Transaction 35 of length 58 [2005/10/04 11:50:23, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:23, 5] lib/util.c:show_msg(464) size=54 smb_com=0xb smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26881 smt_wct=5 smb_vwv[ 0]= 5012 (0x1394) smb_vwv[ 1]= 6 (0x6) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 6 (0x6) smb_bcc=9 [2005/10/04 11:50:23, 10] lib/util.c:dump_data(2053) [000] 01 06 00 78 78 78 20 0D 0A ...xxx . . [2005/10/04 11:50:23, 3] smbd/process.c:switch_message(900) switch message SMBwrite (pid 28332) conn 0x82ef828 [2005/10/04 11:50:23, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:23, 10] locking/locking.c:is_locked(109) is_locked: brl start=0 len=6 unlocked for file 1/test.txt [2005/10/04 11:50:23, 10] locking/posix.c:is_posix_locked(706) is_posix_locked: File 1/test.txt, offset = 0, count = 6, type = READ [2005/10/04 11:50:23, 10] locking/posix.c:posix_lock_in_range(642) posix_lock_in_range: offset_out = 0, count_out = 6 [2005/10/04 11:50:23, 8] locking/posix.c:posix_fcntl_lock(659) posix_fcntl_lock 30 7 0 6 3 [2005/10/04 11:50:23, 8] lib/util.c:fcntl_lock(1815) fcntl_lock 30 7 0 6 3 [2005/10/04 11:50:23, 8] locking/posix.c:posix_fcntl_lock(689) posix_fcntl_lock: Lock call failed [2005/10/04 11:50:23, 10] locking/locking.c:is_locked(121) is_locked: posix start=0 len=6 unlocked for file 1/test.txt [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(294) dos_mode: 1/test.txt [2005/10/04 11:50:23, 10] smbd/dosmode.c:get_ea_dos_attribute(203) get_ea_dos_attribute: 1/test.txt attrstr = 0x20 [2005/10/04 11:50:23, 8] smbd/dosmode.c:get_ea_dos_attribute(216) get_ea_dos_attribute returning (0x20)a [2005/10/04 11:50:23, 8] smbd/dosmode.c:dos_mode(328) dos_mode returning a [2005/10/04 11:50:23, 10] smbd/fileio.c:real_write_file(137) real_write_file (1/test.txt): pos = 0, size = 6, returned -1 [2005/10/04 11:50:23, 3] smbd/error.c:unix_error_packet(91) unix_error_packet: error string = Bad file descriptor [2005/10/04 11:50:23, 3] smbd/error.c:error_packet(163) error packet at smbd/reply.c(2948) cmd=11 (SMBwrite) eclass=2 ecode=65 [2005/10/04 11:50:23, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:23, 5] lib/util.c:show_msg(464) size=35 smb_com=0xb smb_rcls=2 smb_reh=0 smb_err=65 smb_flg=128 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=26881 smt_wct=0 smb_bcc=0 [2005/10/04 11:50:23, 10] lib/util_sock.c:read_smb_length_return_keepalive(615) got smb length of 41 [2005/10/04 11:50:23, 6] smbd/process.c:process_smb(1113) got message type 0x0 of len 0x29 [2005/10/04 11:50:23, 3] smbd/process.c:process_smb(1114) Transaction 36 of length 45 [2005/10/04 11:50:23, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:23, 5] lib/util.c:show_msg(464) size=41 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=0 smb_flg2=32768 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=27009 smt_wct=3 smb_vwv[ 0]= 5012 (0x1394) smb_vwv[ 1]=31374 (0x7A8E) smb_vwv[ 2]=17218 (0x4342) smb_bcc=0 [2005/10/04 11:50:23, 3] smbd/process.c:switch_message(900) switch message SMBclose (pid 28332) conn 0x82ef828 [2005/10/04 11:50:23, 4] smbd/uid.c:change_to_user(217) change_to_user: Skipping user change - already user [2005/10/04 11:50:23, 3] smbd/reply.c:reply_close(3247) close fd=30 fnum=5012 (numopen=1) [2005/10/04 11:50:23, 10] locking/locking.c:del_share_entry(658) del_share_entry: num_share_modes = 1 [2005/10/04 11:50:23, 10] locking/locking.c:del_share_entry(663) del_share_entry: deleted share_mode_entry[0]: pid = 28332, share_access = 0x1, private_options = 0x0, access_mask = 0x12019f, port = 0x0, type= 0x0, file_id = 1, dev = 0x415, inode = 779539 [2005/10/04 11:50:23, 10] locking/locking.c:del_share_entry(673) del_share_entry: deleting entry 0 [2005/10/04 11:50:23, 10] locking/locking.c:del_share_entry(695) del_share_entry: Remaining table. [2005/10/04 11:50:23, 10] smbd/close.c:close_normal_file(203) close_normal_file: share_entry_count = 0 for file 1/test.txt [2005/10/04 11:50:23, 10] locking/posix.c:posix_locking_close_file(1249) posix_locking_close_file: file 1/test.txt has no outstanding locks. [2005/10/04 11:50:23, 10] smbd/posix_acls.c:check_posix_acl_group_write(4048) check_posix_acl_group_write: ret = -1 before check_stat: [2005/10/04 11:50:23, 10] smbd/posix_acls.c:check_posix_acl_group_write(4069) check_posix_acl_group_write: file 1/test.txt failed to match on user or group in token (ret = -1). [2005/10/04 11:50:23, 10] smbd/posix_acls.c:check_posix_acl_group_write(4078) check_posix_acl_group_write: file 1/test.txt returning (ret = -1). [2005/10/04 11:50:23, 4] smbd/dosmode.c:set_filetime(506) set_filetime(1/test.txt) failed: Operation not permitted [2005/10/04 11:50:23, 2] smbd/close.c:close_normal_file(270) rc20 closed file 1/test.txt (numopen=0) [2005/10/04 11:50:23, 5] smbd/files.c:file_free(459) freed files structure 5012 (0 used) [2005/10/04 11:50:23, 5] lib/util.c:show_msg(454) [2005/10/04 11:50:23, 5] lib/util.c:show_msg(464) size=35 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=128 smb_flg2=32769 smb_tid=1 smb_pid=3864 smb_uid=100 smb_mid=27009 smt_wct=0 smb_bcc=0