[2006/03/06 16:31:12, 10] smbd/process.c:async_processing(403) async_processing: Doing async processing. [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 118 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x76 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 254 of length 122 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=118 smb_com=0xa2 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2690 smt_wct=24 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]=57054 (0xDEDE) smb_vwv[ 2]= 8192 (0x2000) smb_vwv[ 3]= 5632 (0x1600) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]=40704 (0x9F00) smb_vwv[ 8]= 513 (0x201) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]=32768 (0x8000) smb_vwv[14]= 0 (0x0) smb_vwv[15]= 0 (0x0) smb_vwv[16]= 0 (0x0) smb_vwv[17]= 256 (0x100) smb_vwv[18]= 0 (0x0) smb_vwv[19]=16384 (0x4000) smb_vwv[20]= 0 (0x0) smb_vwv[21]= 512 (0x200) smb_vwv[22]= 0 (0x0) smb_vwv[23]= 768 (0x300) smb_bcc=35 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 5C 00 6F 00 75 00 74 00 6C 00 6F 00 6F 00 6B .\.o.u.t .l.o.o.k [010] 00 5C 00 72 00 73 00 63 00 2E 00 70 00 73 00 74 .\.r.s.c ...p.s.t [020] 00 00 00 ... [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBntcreateX (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 10] smbd/nttrans.c:reply_ntcreate_and_X(506) reply_ntcreateX: flags = 0x16, access_mask = 0x2019f file_attributes = 0x80, share_access = 0x0, create_disposition = 0x1 create_options = 0x40 root_dir_fid = 0x0 [2006/03/06 16:31:15, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "outlook/rsc.pst" [2006/03/06 16:31:15, 10] smbd/statcache.c:stat_cache_lookup(248) stat_cache_lookup: lookup succeeded for name [OUTLOOK/RSC.PST] -> [outlook/rsc.pst] [2006/03/06 16:31:15, 3] smbd/dosmode.c:unix_mode(121) unix_mode(outlook/rsc.pst) returning 0700 [2006/03/06 16:31:15, 10] smbd/open.c:open_file_ntcreate(1091) open_file_ntcreate: fname=outlook/rsc.pst, dos_attrs=0x80 access_mask=0x2019f share_access=0x0 create_disposition = 0x1 create_options=0x40 unix mode=0700 oplock_request=3 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.pst [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a[sparse] [2006/03/06 16:31:15, 10] smbd/open.c:open_file_ntcreate(1259) open_file_ntcreate: fname=outlook/rsc.pst, after mapping access_mask=0x2019f [2006/03/06 16:31:15, 5] smbd/files.c:file_new(128) allocated file structure 7715, fnum = 11811 (1 used) [2006/03/06 16:31:15, 4] smbd/open.c:open_file_ntcreate(1490) calling open_file with flags=0x2 flags2=0x0 mode=0700 [2006/03/06 16:31:15, 10] smbd/open.c:fd_open(55) fd_open: name outlook/rsc.pst, flags = 02 mode = 0700, fd = 20. [2006/03/06 16:31:15, 2] smbd/open.c:open_file(350) schnoeing opened file outlook/rsc.pst read=Yes write=Yes (numopen=1) [2006/03/06 16:31:15, 3] smbd/oplock_linux.c:linux_set_kernel_oplock(166) linux_set_kernel_oplock: got kernel oplock on file outlook/rsc.pst, dev = 904, inode = 140689471, file_id = 16 [2006/03/06 16:31:15, 5] smbd/oplock.c:set_file_oplock(125) set_file_oplock: granted oplock on file outlook/rsc.pst, dev = 904, inode = 140689471, file_id = 16, tv_sec = 440c55c3, tv_usec = d5acd [2006/03/06 16:31:15, 10] locking/locking.c:unparse_share_modes(540) unparse_share_modes: del: 0, num: 1 [2006/03/06 16:31:15, 10] locking/locking.c:print_share_mode_table(417) print_share_mode_table: share_mode_entry[0]: pid = 1082, share_access = 0x0, private_options = 0x40, access_mask = 0x2019f, mid = 0x0, type= 0x3, file_id = 16, dev = 0x904, inode = 140689471 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.pst [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a[sparse] [2006/03/06 16:31:15, 5] smbd/nttrans.c:reply_ntcreate_and_X(910) reply_ntcreate_and_X: fnum = 11811, open name = outlook/rsc.pst [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=103 smb_com=0xa2 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2690 smt_wct=34 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 8962 (0x2302) smb_vwv[ 3]= 302 (0x12E) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]=32768 (0x8000) smb_vwv[ 6]=25391 (0x632F) smb_vwv[ 7]=10382 (0x288E) smb_vwv[ 8]=50753 (0xC641) smb_vwv[ 9]=32769 (0x8001) smb_vwv[10]=51696 (0xC9F0) smb_vwv[11]=10502 (0x2906) smb_vwv[12]=50753 (0xC641) smb_vwv[13]=32769 (0x8001) smb_vwv[14]=25391 (0x632F) smb_vwv[15]=10382 (0x288E) smb_vwv[16]=50753 (0xC641) smb_vwv[17]=32769 (0x8001) smb_vwv[18]=25391 (0x632F) smb_vwv[19]=10382 (0x288E) smb_vwv[20]=50753 (0xC641) smb_vwv[21]= 8193 (0x2001) smb_vwv[22]= 2 (0x2) smb_vwv[23]= 0 (0x0) smb_vwv[24]=49152 (0xC000) smb_vwv[25]= 71 (0x47) smb_vwv[26]= 0 (0x0) smb_vwv[27]= 0 (0x0) smb_vwv[28]=12096 (0x2F40) smb_vwv[29]= 72 (0x48) smb_vwv[30]= 0 (0x0) smb_vwv[31]= 0 (0x0) smb_vwv[32]= 1792 (0x700) smb_vwv[33]= 0 (0x0) smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 41 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x29 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 255 of length 45 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=41 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=2754 smt_wct=3 smb_vwv[ 0]=11811 (0x2E23) smb_vwv[ 1]=65535 (0xFFFF) smb_vwv[ 2]=65535 (0xFFFF) smb_bcc=0 [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBclose (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 3] smbd/reply.c:reply_close(3271) close fd=20 fnum=11811 (numopen=1) [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(442) parse_share_modes: delete_on_close: 0, num_share_modes: 1 [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(488) parse_share_modes: share_mode_entry[0]: pid = 1082, share_access = 0x0, private_options = 0x40, access_mask = 0x2019f, mid = 0x0, type= 0x3, file_id = 16, dev = 0x904, inode = 140689471 [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(961, 100) : sec_ctx_stack_ndx = 1 [2006/03/06 16:31:15, 3] smbd/uid.c:push_conn_ctx(393) push_conn_ctx(101) : conn_ctx_stack_ndx = 0 [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2006/03/06 16:31:15, 5] auth/auth_util.c:debug_nt_user_token(433) NT user token: (NULL) [2006/03/06 16:31:15, 5] auth/auth_util.c:debug_unix_user_token(454) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (961, 100) - sec_ctx_stack_ndx = 0 [2006/03/06 16:31:15, 10] smbd/oplock_linux.c:linux_release_kernel_oplock(177) linux_release_kernel_oplock: file outlook/rsc.pst, dev = 904, inode = 140689471 file_id = 16 has kernel oplock state of 1. [2006/03/06 16:31:15, 10] locking/posix.c:posix_locking_close_file(1249) posix_locking_close_file: file outlook/rsc.pst has no outstanding locks. [2006/03/06 16:31:15, 2] smbd/close.c:close_normal_file(308) schnoeing closed file outlook/rsc.pst (numopen=0) [2006/03/06 16:31:15, 5] smbd/files.c:file_free(450) freed files structure 11811 (0 used) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=35 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=2754 smt_wct=0 smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 118 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x76 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 256 of length 122 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=118 smb_com=0xa2 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2818 smt_wct=24 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]=57054 (0xDEDE) smb_vwv[ 2]= 8192 (0x2000) smb_vwv[ 3]= 5632 (0x1600) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]=40704 (0x9F00) smb_vwv[ 8]= 513 (0x201) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]=32768 (0x8000) smb_vwv[14]= 0 (0x0) smb_vwv[15]= 256 (0x100) smb_vwv[16]= 0 (0x0) smb_vwv[17]= 256 (0x100) smb_vwv[18]= 0 (0x0) smb_vwv[19]=16384 (0x4000) smb_vwv[20]= 0 (0x0) smb_vwv[21]= 512 (0x200) smb_vwv[22]= 0 (0x0) smb_vwv[23]= 768 (0x300) smb_bcc=35 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 5C 00 6F 00 75 00 74 00 6C 00 6F 00 6F 00 6B .\.o.u.t .l.o.o.k [010] 00 5C 00 72 00 73 00 63 00 2E 00 6C 00 6F 00 67 .\.r.s.c ...l.o.g [020] 00 00 00 ... [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBntcreateX (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 10] smbd/nttrans.c:reply_ntcreate_and_X(506) reply_ntcreateX: flags = 0x16, access_mask = 0x2019f file_attributes = 0x80, share_access = 0x1, create_disposition = 0x1 create_options = 0x40 root_dir_fid = 0x0 [2006/03/06 16:31:15, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "outlook/rsc.log" [2006/03/06 16:31:15, 10] smbd/statcache.c:stat_cache_lookup(248) stat_cache_lookup: lookup succeeded for name [OUTLOOK/RSC.LOG] -> [outlook/rsc.log] [2006/03/06 16:31:15, 3] smbd/dosmode.c:unix_mode(121) unix_mode(outlook/rsc.log) returning 0700 [2006/03/06 16:31:15, 10] smbd/open.c:open_file_ntcreate(1091) open_file_ntcreate: fname=outlook/rsc.log, dos_attrs=0x80 access_mask=0x2019f share_access=0x1 create_disposition = 0x1 create_options=0x40 unix mode=0700 oplock_request=3 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 10] smbd/open.c:open_file_ntcreate(1259) open_file_ntcreate: fname=outlook/rsc.log, after mapping access_mask=0x2019f [2006/03/06 16:31:15, 5] smbd/files.c:file_new(128) allocated file structure 7716, fnum = 11812 (1 used) [2006/03/06 16:31:15, 4] smbd/open.c:open_file_ntcreate(1490) calling open_file with flags=0x2 flags2=0x0 mode=0700 [2006/03/06 16:31:15, 10] smbd/open.c:fd_open(55) fd_open: name outlook/rsc.log, flags = 02 mode = 0700, fd = 20. [2006/03/06 16:31:15, 2] smbd/open.c:open_file(350) schnoeing opened file outlook/rsc.log read=Yes write=Yes (numopen=1) [2006/03/06 16:31:15, 3] smbd/oplock_linux.c:linux_set_kernel_oplock(166) linux_set_kernel_oplock: got kernel oplock on file outlook/rsc.log, dev = 904, inode = 145555528, file_id = 17 [2006/03/06 16:31:15, 5] smbd/oplock.c:set_file_oplock(125) set_file_oplock: granted oplock on file outlook/rsc.log, dev = 904, inode = 145555528, file_id = 17, tv_sec = 440c55c3, tv_usec = db7f3 [2006/03/06 16:31:15, 10] locking/locking.c:unparse_share_modes(540) unparse_share_modes: del: 0, num: 1 [2006/03/06 16:31:15, 10] locking/locking.c:print_share_mode_table(417) print_share_mode_table: share_mode_entry[0]: pid = 1082, share_access = 0x1, private_options = 0x40, access_mask = 0x2019f, mid = 0x0, type= 0x3, file_id = 17, dev = 0x904, inode = 145555528 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 5] smbd/nttrans.c:reply_ntcreate_and_X(910) reply_ntcreate_and_X: fnum = 11812, open name = outlook/rsc.log [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=103 smb_com=0xa2 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2818 smt_wct=34 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 9218 (0x2402) smb_vwv[ 3]= 302 (0x12E) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]=33344 (0x8240) smb_vwv[ 7]=13017 (0x32D9) smb_vwv[ 8]=50753 (0xC641) smb_vwv[ 9]= 1 (0x1) smb_vwv[10]=33344 (0x8240) smb_vwv[11]=13017 (0x32D9) smb_vwv[12]=50753 (0xC641) smb_vwv[13]= 1 (0x1) smb_vwv[14]=10391 (0x2897) smb_vwv[15]=13040 (0x32F0) smb_vwv[16]=50753 (0xC641) smb_vwv[17]= 1 (0x1) smb_vwv[18]=10391 (0x2897) smb_vwv[19]=13040 (0x32F0) smb_vwv[20]=50753 (0xC641) smb_vwv[21]= 8193 (0x2001) smb_vwv[22]= 0 (0x0) smb_vwv[23]= 0 (0x0) smb_vwv[24]= 4096 (0x1000) smb_vwv[25]= 0 (0x0) smb_vwv[26]= 0 (0x0) smb_vwv[27]=50944 (0xC700) smb_vwv[28]= 0 (0x0) smb_vwv[29]= 0 (0x0) smb_vwv[30]= 0 (0x0) smb_vwv[31]= 0 (0x0) smb_vwv[32]= 1792 (0x700) smb_vwv[33]= 0 (0x0) smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 84 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x54 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 257 of length 88 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=84 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2882 smt_wct=15 smb_vwv[ 0]= 6 (0x6) smb_vwv[ 1]= 8 (0x8) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 0 (0x0) 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]= 6 (0x6) smb_vwv[10]= 68 (0x44) smb_vwv[11]= 8 (0x8) smb_vwv[12]= 76 (0x4C) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 8 (0x8) smb_bcc=19 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 00 00 24 2E FC 03 00 00 00 00 00 00 00 00 00 ...$.... ........ [010] 00 00 00 ... [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBtrans2 (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 3] smbd/trans2.c:call_trans2setfilepathinfo(3702) call_trans2setfilepathinfo(8) outlook/rsc.log (fnum 11812) info_level=1020 totdata=8 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 10] smbd/trans2.c:call_trans2setfilepathinfo(3934) call_trans2setfilepathinfo: Set end of file info for file outlook/rsc.log to 0 [2006/03/06 16:31:15, 6] smbd/trans2.c:call_trans2setfilepathinfo(4363) actime: Mon Mar 6 16:30:08 2006 modtime: Mon Mar 6 16:30:46 2006 size: 0 dosmode: 20 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 10] smbd/trans2.c:call_trans2setfilepathinfo(4411) call_trans2setfilepathinfo: file outlook/rsc.log : setting new size to 0 [2006/03/06 16:31:15, 10] smbd/vfs.c:vfs_set_filelen(593) vfs_set_filelen: ftruncate outlook/rsc.log to len 0 [2006/03/06 16:31:15, 9] smbd/trans2.c:send_trans2_replies(685) t2_rep: params_sent_thistime = 2, data_sent_thistime = 0, useable_space = 131012 [2006/03/06 16:31:15, 9] smbd/trans2.c:send_trans2_replies(687) t2_rep: params_to_send = 2, data_to_send = 0, paramsize = 2, datasize = 0 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=58 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51265 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2882 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) 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=3 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 00 00 ... [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 84 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x54 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 258 of length 88 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=84 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2946 smt_wct=15 smb_vwv[ 0]= 6 (0x6) smb_vwv[ 1]= 8 (0x8) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]= 0 (0x0) 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]= 6 (0x6) smb_vwv[10]= 68 (0x44) smb_vwv[11]= 8 (0x8) smb_vwv[12]= 76 (0x4C) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 8 (0x8) smb_bcc=19 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 00 00 24 2E FB 03 00 00 00 00 00 00 00 00 00 ...$.... ........ [010] 00 00 00 ... [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBtrans2 (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 3] smbd/trans2.c:call_trans2setfilepathinfo(3702) call_trans2setfilepathinfo(8) outlook/rsc.log (fnum 11812) info_level=1019 totdata=8 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 10] smbd/trans2.c:call_trans2setfilepathinfo(3868) call_trans2setfilepathinfo: Set file allocation info for file outlook/rsc.log to 0 [2006/03/06 16:31:15, 6] smbd/trans2.c:call_trans2setfilepathinfo(4363) actime: Mon Mar 6 16:30:08 2006 modtime: Mon Mar 6 16:31:15 2006 size: 0 dosmode: 20 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 9] smbd/trans2.c:send_trans2_replies(685) t2_rep: params_sent_thistime = 2, data_sent_thistime = 0, useable_space = 131012 [2006/03/06 16:31:15, 9] smbd/trans2.c:send_trans2_replies(687) t2_rep: params_to_send = 2, data_to_send = 0, paramsize = 2, datasize = 0 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=58 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51265 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=2946 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) 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=3 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 00 00 ... [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 65 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x41 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 259 of length 69 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=65 smb_com=0x2f smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=59399 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3010 smt_wct=14 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]=57054 (0xDEDE) smb_vwv[ 2]=11812 (0x2E24) smb_vwv[ 3]= 98 (0x62) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]=65535 (0xFFFF) smb_vwv[ 6]=65535 (0xFFFF) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 1 (0x1) smb_vwv[11]= 64 (0x40) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 0 (0x0) smb_bcc=2 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] EE 00 .. [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBwriteX (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 10] locking/locking.c:is_locked(109) is_locked: brl start=98 len=1 unlocked for file outlook/rsc.log [2006/03/06 16:31:15, 10] locking/posix.c:is_posix_locked(706) is_posix_locked: File outlook/rsc.log, offset = 98, count = 1, type = WRITE [2006/03/06 16:31:15, 10] locking/posix.c:posix_lock_in_range(642) posix_lock_in_range: offset_out = 98, count_out = 1 [2006/03/06 16:31:15, 8] locking/posix.c:posix_fcntl_lock(659) posix_fcntl_lock 20 5 98 1 1 [2006/03/06 16:31:15, 8] lib/util.c:fcntl_lock(1820) fcntl_lock 20 5 98 1 1 [2006/03/06 16:31:15, 8] locking/posix.c:posix_fcntl_lock(689) posix_fcntl_lock: Lock call failed [2006/03/06 16:31:15, 10] locking/locking.c:is_locked(121) is_locked: posix start=98 len=1 unlocked for file outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 10] smbd/fileio.c:real_write_file(137) real_write_file (outlook/rsc.log): pos = 98, size = 1, returned 1 [2006/03/06 16:31:15, 3] smbd/reply.c:reply_write_and_X(3094) writeX fnum=11812 num=1 wrote=1 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=47 smb_com=0x2f smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3010 smt_wct=6 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 1 (0x1) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 80 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x50 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 260 of length 84 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=80 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3074 smt_wct=15 smb_vwv[ 0]= 4 (0x4) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 100 (0x64) smb_vwv[ 3]= 800 (0x320) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 4 (0x4) smb_vwv[10]= 72 (0x48) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 80 (0x50) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 7 (0x7) smb_bcc=15 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 EE EE EE EE EE EE 24 2E 02 01 EE EE EE EE .......$ ....... [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBtrans2 (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 3] smbd/trans2.c:call_trans2qfilepathinfo(2799) call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 258 [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(442) parse_share_modes: delete_on_close: 0, num_share_modes: 1 [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(488) parse_share_modes: share_mode_entry[0]: pid = 1082, share_access = 0x1, private_options = 0x40, access_mask = 0x2019f, mid = 0x0, type= 0x3, file_id = 17, dev = 0x904, inode = 145555528 [2006/03/06 16:31:15, 3] smbd/trans2.c:call_trans2qfilepathinfo(2913) call_trans2qfilepathinfo outlook/rsc.log (fnum = 11812) level=258 call=7 total_data=0 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.log [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a [2006/03/06 16:31:15, 10] smbd/trans2.c:call_trans2qfilepathinfo(3132) call_trans2qfilepathinfo: SMB_FILE_STANDARD_INFORMATION [2006/03/06 16:31:15, 9] smbd/trans2.c:send_trans2_replies(685) t2_rep: params_sent_thistime = 2, data_sent_thistime = 24, useable_space = 131010 [2006/03/06 16:31:15, 9] smbd/trans2.c:send_trans2_replies(687) t2_rep: params_to_send = 2, data_to_send = 24, paramsize = 2, datasize = 24 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=84 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51265 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3074 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 24 (0x18) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 24 (0x18) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=29 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 00 00 00 00 00 00 10 00 00 00 00 00 63 00 00 ........ .....c.. [010] 00 00 00 00 00 01 00 00 00 00 00 00 00 ........ ..... [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 118 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x76 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 261 of length 122 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=118 smb_com=0xa2 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=3138 smt_wct=24 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]=57054 (0xDEDE) smb_vwv[ 2]= 8192 (0x2000) smb_vwv[ 3]= 5632 (0x1600) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 0 (0x0) smb_vwv[ 7]=35072 (0x8900) smb_vwv[ 8]= 512 (0x200) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 0 (0x0) smb_vwv[13]=32768 (0x8000) smb_vwv[14]= 0 (0x0) smb_vwv[15]= 0 (0x0) smb_vwv[16]= 0 (0x0) smb_vwv[17]= 256 (0x100) smb_vwv[18]= 0 (0x0) smb_vwv[19]=16384 (0x4000) smb_vwv[20]= 0 (0x0) smb_vwv[21]= 512 (0x200) smb_vwv[22]= 0 (0x0) smb_vwv[23]= 768 (0x300) smb_bcc=35 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] 00 5C 00 6F 00 75 00 74 00 6C 00 6F 00 6F 00 6B .\.o.u.t .l.o.o.k [010] 00 5C 00 72 00 73 00 63 00 2E 00 70 00 73 00 74 .\.r.s.c ...p.s.t [020] 00 00 00 ... [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBntcreateX (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 10] smbd/nttrans.c:reply_ntcreate_and_X(506) reply_ntcreateX: flags = 0x16, access_mask = 0x20089 file_attributes = 0x80, share_access = 0x0, create_disposition = 0x1 create_options = 0x40 root_dir_fid = 0x0 [2006/03/06 16:31:15, 5] smbd/filename.c:unix_convert(108) unix_convert called on file "outlook/rsc.pst" [2006/03/06 16:31:15, 10] smbd/statcache.c:stat_cache_lookup(248) stat_cache_lookup: lookup succeeded for name [OUTLOOK/RSC.PST] -> [outlook/rsc.pst] [2006/03/06 16:31:15, 3] smbd/dosmode.c:unix_mode(121) unix_mode(outlook/rsc.pst) returning 0700 [2006/03/06 16:31:15, 10] smbd/open.c:open_file_ntcreate(1091) open_file_ntcreate: fname=outlook/rsc.pst, dos_attrs=0x80 access_mask=0x20089 share_access=0x0 create_disposition = 0x1 create_options=0x40 unix mode=0700 oplock_request=3 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.pst [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a[sparse] [2006/03/06 16:31:15, 10] smbd/open.c:open_file_ntcreate(1259) open_file_ntcreate: fname=outlook/rsc.pst, after mapping access_mask=0x20089 [2006/03/06 16:31:15, 5] smbd/files.c:file_new(128) allocated file structure 7717, fnum = 11813 (2 used) [2006/03/06 16:31:15, 4] smbd/open.c:open_file_ntcreate(1490) calling open_file with flags=0x0 flags2=0x0 mode=0700 [2006/03/06 16:31:15, 10] smbd/open.c:fd_open(55) fd_open: name outlook/rsc.pst, flags = 00 mode = 0700, fd = 25. [2006/03/06 16:31:15, 2] smbd/open.c:open_file(350) schnoeing opened file outlook/rsc.pst read=Yes write=No (numopen=2) [2006/03/06 16:31:15, 3] smbd/oplock_linux.c:linux_set_kernel_oplock(166) linux_set_kernel_oplock: got kernel oplock on file outlook/rsc.pst, dev = 904, inode = 140689471, file_id = 18 [2006/03/06 16:31:15, 5] smbd/oplock.c:set_file_oplock(125) set_file_oplock: granted oplock on file outlook/rsc.pst, dev = 904, inode = 140689471, file_id = 18, tv_sec = 440c55c3, tv_usec = ddb3f [2006/03/06 16:31:15, 10] locking/locking.c:unparse_share_modes(540) unparse_share_modes: del: 0, num: 1 [2006/03/06 16:31:15, 10] locking/locking.c:print_share_mode_table(417) print_share_mode_table: share_mode_entry[0]: pid = 1082, share_access = 0x0, private_options = 0x40, access_mask = 0x20089, mid = 0x0, type= 0x3, file_id = 18, dev = 0x904, inode = 140689471 [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(300) dos_mode: outlook/rsc.pst [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode_from_sbuf(167) dos_mode_from_sbuf returning a [2006/03/06 16:31:15, 8] smbd/dosmode.c:dos_mode(334) dos_mode returning a[sparse] [2006/03/06 16:31:15, 5] smbd/nttrans.c:reply_ntcreate_and_X(910) reply_ntcreate_and_X: fnum = 11813, open name = outlook/rsc.pst [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=103 smb_com=0xa2 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=912 smb_uid=101 smb_mid=3138 smt_wct=34 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 9474 (0x2502) smb_vwv[ 3]= 302 (0x12E) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]=32768 (0x8000) smb_vwv[ 6]=25391 (0x632F) smb_vwv[ 7]=10382 (0x288E) smb_vwv[ 8]=50753 (0xC641) smb_vwv[ 9]=32769 (0x8001) smb_vwv[10]=51696 (0xC9F0) smb_vwv[11]=10502 (0x2906) smb_vwv[12]=50753 (0xC641) smb_vwv[13]=32769 (0x8001) smb_vwv[14]=25391 (0x632F) smb_vwv[15]=10382 (0x288E) smb_vwv[16]=50753 (0xC641) smb_vwv[17]=32769 (0x8001) smb_vwv[18]=25391 (0x632F) smb_vwv[19]=10382 (0x288E) smb_vwv[20]=50753 (0xC641) smb_vwv[21]= 8193 (0x2001) smb_vwv[22]= 2 (0x2) smb_vwv[23]= 0 (0x0) smb_vwv[24]=49152 (0xC000) smb_vwv[25]= 71 (0x47) smb_vwv[26]= 0 (0x0) smb_vwv[27]= 0 (0x0) smb_vwv[28]=12096 (0x2F40) smb_vwv[29]= 72 (0x48) smb_vwv[30]= 0 (0x0) smb_vwv[31]= 0 (0x0) smb_vwv[32]= 1792 (0x700) smb_vwv[33]= 0 (0x0) smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 59 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x3b [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 262 of length 63 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=59 smb_com=0x2e smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=59399 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3202 smt_wct=12 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]=57054 (0xDEDE) smb_vwv[ 2]=11813 (0x2E25) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 4096 (0x1000) smb_vwv[ 6]= 4096 (0x1000) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 4096 (0x1000) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 0 (0x0) smb_bcc=0 [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBreadX (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 10] locking/locking.c:is_locked(109) is_locked: brl start=0 len=4096 locked for file outlook/rsc.pst [2006/03/06 16:31:15, 3] smbd/error.c:error_packet(146) error packet at smbd/reply.c(2686) cmd=46 (SMBreadX) NT_STATUS_FILE_LOCK_CONFLICT [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=35 smb_com=0x2e smb_rcls=84 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3202 smt_wct=0 smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 59 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x3b [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 263 of length 63 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=59 smb_com=0x2e smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=59399 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3266 smt_wct=12 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]=57054 (0xDEDE) smb_vwv[ 2]=11813 (0x2E25) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 4096 (0x1000) smb_vwv[ 6]= 4096 (0x1000) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 4096 (0x1000) smb_vwv[10]= 0 (0x0) smb_vwv[11]= 0 (0x0) smb_bcc=0 [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBreadX (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 10] locking/locking.c:is_locked(109) is_locked: brl start=0 len=4096 locked for file outlook/rsc.pst [2006/03/06 16:31:15, 3] smbd/error.c:error_packet(146) error packet at smbd/reply.c(2686) cmd=46 (SMBreadX) NT_STATUS_FILE_LOCK_CONFLICT [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=35 smb_com=0x2e smb_rcls=84 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3266 smt_wct=0 smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 41 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x29 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 264 of length 45 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=41 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3330 smt_wct=3 smb_vwv[ 0]=11813 (0x2E25) smb_vwv[ 1]=65535 (0xFFFF) smb_vwv[ 2]=65535 (0xFFFF) smb_bcc=0 [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBclose (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 3] smbd/reply.c:reply_close(3271) close fd=25 fnum=11813 (numopen=2) [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(442) parse_share_modes: delete_on_close: 0, num_share_modes: 1 [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(488) parse_share_modes: share_mode_entry[0]: pid = 1082, share_access = 0x0, private_options = 0x40, access_mask = 0x20089, mid = 0x0, type= 0x3, file_id = 18, dev = 0x904, inode = 140689471 [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(961, 100) : sec_ctx_stack_ndx = 1 [2006/03/06 16:31:15, 3] smbd/uid.c:push_conn_ctx(393) push_conn_ctx(101) : conn_ctx_stack_ndx = 0 [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2006/03/06 16:31:15, 5] auth/auth_util.c:debug_nt_user_token(433) NT user token: (NULL) [2006/03/06 16:31:15, 5] auth/auth_util.c:debug_unix_user_token(454) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (961, 100) - sec_ctx_stack_ndx = 0 [2006/03/06 16:31:15, 10] smbd/oplock_linux.c:linux_release_kernel_oplock(177) linux_release_kernel_oplock: file outlook/rsc.pst, dev = 904, inode = 140689471 file_id = 18 has kernel oplock state of 1. [2006/03/06 16:31:15, 10] locking/posix.c:posix_locking_close_file(1249) posix_locking_close_file: file outlook/rsc.pst has no outstanding locks. [2006/03/06 16:31:15, 2] smbd/close.c:close_normal_file(308) schnoeing closed file outlook/rsc.pst (numopen=1) [2006/03/06 16:31:15, 5] smbd/files.c:file_free(450) freed files structure 11813 (1 used) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=35 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3330 smt_wct=0 smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 263 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x107 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 265 of length 267 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=263 smb_com=0x2f smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=59399 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3394 smt_wct=14 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]=57054 (0xDEDE) smb_vwv[ 2]=11812 (0x2E24) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]=65535 (0xFFFF) smb_vwv[ 6]=65535 (0xFFFF) smb_vwv[ 7]= 0 (0x0) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_vwv[10]= 199 (0xC7) smb_vwv[11]= 64 (0x40) smb_vwv[12]= 0 (0x0) smb_vwv[13]= 0 (0x0) smb_bcc=200 [2006/03/06 16:31:15, 10] lib/util.c:dump_data(2058) [000] EE 0D 0A 4D 69 63 72 6F 73 6F 66 74 20 28 52 29 ...Micro soft (R) [010] 20 49 6E 62 6F 78 20 52 65 70 61 69 72 20 54 6F Inbox R epair To [020] 6F 6C 0D 0A 43 6F 70 79 72 69 67 68 74 20 28 43 ol..Copy right (C [030] 29 20 4D 69 63 72 6F 73 6F 66 74 20 43 6F 72 70 ) Micros oft Corp [040] 20 31 39 39 35 2D 31 39 39 36 2E 20 41 6C 6C 20 1995-19 96. All [050] 72 69 67 68 74 73 20 72 65 73 65 72 76 65 64 2E rights r eserved. [060] 0D 0A 0D 0A 2A 2A 42 65 67 69 6E 6E 69 6E 67 20 ....**Be ginning [070] 4E 44 42 20 72 65 63 6F 76 65 72 79 0D 0A 0D 0A NDB reco very.... [080] 20 20 2A 2A 41 74 74 65 6D 70 74 69 6E 67 20 74 **Atte mpting t [090] 6F 20 6F 70 65 6E 20 64 61 74 61 62 61 73 65 0D o open d atabase. [0A0] 0A 0D 0A 20 20 2A 2A 41 74 74 65 6D 70 74 69 6E ... **A ttemptin [0B0] 67 20 74 6F 20 76 61 6C 69 64 61 74 65 20 68 65 g to val idate he [0C0] 61 64 65 72 0D 0A 0D 0A ader.... [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBwriteX (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 10] locking/locking.c:is_locked(109) is_locked: brl start=0 len=199 unlocked for file outlook/rsc.log [2006/03/06 16:31:15, 10] locking/posix.c:is_posix_locked(706) is_posix_locked: File outlook/rsc.log, offset = 0, count = 199, type = WRITE [2006/03/06 16:31:15, 10] locking/posix.c:posix_lock_in_range(642) posix_lock_in_range: offset_out = 0, count_out = 199 [2006/03/06 16:31:15, 8] locking/posix.c:posix_fcntl_lock(659) posix_fcntl_lock 20 5 0 199 1 [2006/03/06 16:31:15, 8] lib/util.c:fcntl_lock(1820) fcntl_lock 20 5 0 199 1 [2006/03/06 16:31:15, 8] locking/posix.c:posix_fcntl_lock(689) posix_fcntl_lock: Lock call failed [2006/03/06 16:31:15, 10] locking/locking.c:is_locked(121) is_locked: posix start=0 len=199 unlocked for file outlook/rsc.log [2006/03/06 16:31:15, 10] smbd/fileio.c:real_write_file(137) real_write_file (outlook/rsc.log): pos = 0, size = 199, returned 199 [2006/03/06 16:31:15, 3] smbd/reply.c:reply_write_and_X(3094) writeX fnum=11812 num=199 wrote=199 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=47 smb_com=0x2f smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3394 smt_wct=6 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 199 (0xC7) smb_vwv[ 3]= 0 (0x0) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 0 (0x0) smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:15, 10] lib/util_sock.c:read_smb_length_return_keepalive(618) got smb length of 41 [2006/03/06 16:31:15, 6] smbd/process.c:process_smb(1193) got message type 0x0 of len 0x29 [2006/03/06 16:31:15, 3] smbd/process.c:process_smb(1194) Transaction 266 of length 45 [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=41 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=24 smb_flg2=51207 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3458 smt_wct=3 smb_vwv[ 0]=11812 (0x2E24) smb_vwv[ 1]=65535 (0xFFFF) smb_vwv[ 2]=65535 (0xFFFF) smb_bcc=0 [2006/03/06 16:31:15, 3] smbd/process.c:switch_message(993) switch message SMBclose (pid 1082) conn 0x8b1880 [2006/03/06 16:31:15, 4] smbd/uid.c:change_to_user(222) change_to_user: Skipping user change - already user [2006/03/06 16:31:15, 3] smbd/reply.c:reply_close(3271) close fd=20 fnum=11812 (numopen=1) [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(442) parse_share_modes: delete_on_close: 0, num_share_modes: 1 [2006/03/06 16:31:15, 10] locking/locking.c:parse_share_modes(488) parse_share_modes: share_mode_entry[0]: pid = 1082, share_access = 0x1, private_options = 0x40, access_mask = 0x2019f, mid = 0x0, type= 0x3, file_id = 17, dev = 0x904, inode = 145555528 [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:push_sec_ctx(256) push_sec_ctx(961, 100) : sec_ctx_stack_ndx = 1 [2006/03/06 16:31:15, 3] smbd/uid.c:push_conn_ctx(393) push_conn_ctx(101) : conn_ctx_stack_ndx = 0 [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:set_sec_ctx(288) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2006/03/06 16:31:15, 5] auth/auth_util.c:debug_nt_user_token(433) NT user token: (NULL) [2006/03/06 16:31:15, 5] auth/auth_util.c:debug_unix_user_token(454) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2006/03/06 16:31:15, 3] smbd/sec_ctx.c:pop_sec_ctx(386) pop_sec_ctx (961, 100) - sec_ctx_stack_ndx = 0 [2006/03/06 16:31:15, 10] smbd/oplock_linux.c:linux_release_kernel_oplock(177) linux_release_kernel_oplock: file outlook/rsc.log, dev = 904, inode = 145555528 file_id = 17 has kernel oplock state of 1. [2006/03/06 16:31:15, 10] locking/posix.c:posix_locking_close_file(1249) posix_locking_close_file: file outlook/rsc.log has no outstanding locks. [2006/03/06 16:31:15, 2] smbd/close.c:close_normal_file(308) schnoeing closed file outlook/rsc.log (numopen=0) [2006/03/06 16:31:15, 5] smbd/files.c:file_free(450) freed files structure 11812 (0 used) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(454) [2006/03/06 16:31:15, 5] lib/util.c:show_msg(464) size=35 smb_com=0x4 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=65279 smb_uid=101 smb_mid=3458 smt_wct=0 smb_bcc=0 [2006/03/06 16:31:15, 10] smbd/process.c:setup_select_timeout(1372) change_notify_timeout: -1 [2006/03/06 16:31:15, 10] smbd/process.c:run_events(299) run_events: No events [2006/03/06 16:31:17, 10] smbd/process.c:async_processing(403) async_processing: Doing async processing.