Attachment 4235 Details for Bug 6430 – log.smb.old

log.smb.old

log.smbd.old (text/plain), 123.56 KB, created by Colin Coe on 2009-06-01 20:31:30 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Colin Coe

Created: 2009-06-01 20:31:30 UTC

Size: 123.56 KB

patch

obsolete

>[2009/06/02 09:07:36,  5] smbd/uid.c:change_to_root_user(329)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 84
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x54
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2000 of length 88 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=84
>  smb_com=0xa0
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=43840
>  smt_wct=23
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  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]=   64 (0x40)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=21504 (0x5400)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    0 (0x0)
>  smb_vwv[14]=    0 (0x0)
>  smb_vwv[15]=    0 (0x0)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]= 1024 (0x400)
>  smb_vwv[18]=    2 (0x2)
>  smb_vwv[19]=  168 (0xA8)
>  smb_vwv[20]=    9 (0x9)
>  smb_vwv[21]=12737 (0x31C1)
>  smb_vwv[22]=    1 (0x1)
>  smb_bcc=3
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00                                          ... 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnttrans (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36, 10] smbd/share_access.c:user_ok_token(234)
>  user_ok_token: share datafiles is ok for unix user enmac
>[2009/06/02 09:07:36, 10] smbd/share_access.c:is_share_read_only_for_token(279)
>  is_share_read_only_for_user: share datafiles is read-write for unix user enmac
>[2009/06/02 09:07:36, 10] lib/util_seaccess.c:se_map_generic(58)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2009/06/02 09:07:36, 10] lib/util_seaccess.c:se_map_generic(58)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2009/06/02 09:07:36,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (500, 500) - sec_ctx_stack_ndx = 0
>[2009/06/02 09:07:36,  5] auth/token_util.c:debug_nt_user_token(528)
>  NT user token of user S-1-22-1-500
>  contains 6 SIDs
>  SID[  0]: S-1-22-1-500
>  SID[  1]: S-1-22-2-500
>  SID[  2]: S-1-1-0
>  SID[  3]: S-1-5-2
>  SID[  4]: S-1-5-11
>  SID[  5]: S-1-22-2-4294967294
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2009/06/02 09:07:36,  5] auth/token_util.c:debug_unix_user_token(548)
>  UNIX token of user 500
>  Primary group is 500 and contains 2 supplementary groups
>  Group[  0]: 500
>  Group[  1]: 4294967294
>[2009/06/02 09:07:36,  5] smbd/uid.c:change_to_user(314)
>  change_to_user uid=(0,500) gid=(0,500)
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:reply_nttrans(2682)
>  reply_nttrans: state->setup_count = 8
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] A8 00 09 00 C1 31 01 00                           ¨...Á1.. 
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1741)
>  call_nt_transact_ioctl: function[0x000900A8] FID[0x31C1] isFSctl[0x01] compfilter[0x00]
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1791)
>  FSCTL_GET_REPARSE_POINT: called on FID[0x31C1](but not implemented)
>[2009/06/02 09:07:36,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/nttrans.c(1792) cmd=160 (SMBnttrans) NT_STATUS_NOT_A_REPARSE_POINT
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0xa0
>  smb_rcls=117
>  smb_reh=2
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=43840
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 41
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x29
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2001 of length 45 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  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=0
>  smb_mid=43904
>  smt_wct=3
>  smb_vwv[ 0]=12737 (0x31C1)
>  smb_vwv[ 1]=65535 (0xFFFF)
>  smb_vwv[ 2]=65535 (0xFFFF)
>  smb_bcc=0
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBclose (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/reply.c:reply_close(4343)
>  close directory fnum=12737
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000001700
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24fd60
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Wed 14 Jan 2009 09:24:21 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 1
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x0, gen_id = 501, uid = 500, flags = 0, file_id fd00:1100017
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000001700
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12737 (2 used)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x4
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=43904
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 112
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x70
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2002 of length 116 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=112
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=43968
>  smt_wct=15
>  smb_vwv[ 0]=   44 (0x2C)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   40 (0x28)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=   44 (0x2C)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    5 (0x5)
>  smb_bcc=47
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 EC 03 00 00 00  00 5C 00 73 00 79 00 6D  ...ì.... .\.s.y.m
>  [010] 00 62 00 6F 00 6C 00 73  00 5C 00 74 00 65 00 6D  .b.o.l.s .\.t.e.m
>  [020] 00 70 00 6C 00 61 00 74  00 65 00 73 00 00 00     .p.l.a.t .e.s...
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3943)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
>[2009/06/02 09:07:36,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "symbols/templates"
>[2009/06/02 09:07:36, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [SYMBOLS/TEMPLATES] -> [symbols/templates]
>[2009/06/02 09:07:36, 10] locking/locking.c:fetch_share_mode_unlocked(858)
>  fetch_share_mode_unlocked: no share_mode record around (file not open)
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates (fnum = -1) level=1004 call=5 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4299)
>  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
>[2009/06/02 09:07:36,  5] smbd/trans2.c:call_trans2qfilepathinfo(4309)
>  SMB_QFBI - create: Wed Dec 21 11:52:51 2005
>   access: Fri May 22 12:32:54 2009
>   write: Wed Dec 21 11:52:51 2005
>   change: Wed Dec 21 11:52:51 2005
>   mode: 10
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 40, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 40, paramsize = 2, datasize = 40
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=100
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=43968
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=   40 (0x28)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   40 (0x28)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=45
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 80 6B BB  03 E2 05 C6 01 00 1F 90  ......k» .â.Æ....
>  [010] 5F 96 DA C9 01 80 6B BB  03 E2 05 C6 01 80 6B BB  _.ÚÉ..k» .â.Æ..k»
>  [020] 03 E2 05 C6 01 10 00 00  00 00 00 00 00           .â.Æ.... .....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 112
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x70
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2003 of length 116 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=112
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44032
>  smt_wct=15
>  smb_vwv[ 0]=   44 (0x2C)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   40 (0x28)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=   44 (0x2C)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    5 (0x5)
>  smb_bcc=47
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 EC 03 00 00 00  00 5C 00 73 00 79 00 6D  ...ì.... .\.s.y.m
>  [010] 00 62 00 6F 00 6C 00 73  00 5C 00 74 00 65 00 6D  .b.o.l.s .\.t.e.m
>  [020] 00 70 00 6C 00 61 00 74  00 65 00 73 00 00 00     .p.l.a.t .e.s...
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3943)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
>[2009/06/02 09:07:36,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "symbols/templates"
>[2009/06/02 09:07:36, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [SYMBOLS/TEMPLATES] -> [symbols/templates]
>[2009/06/02 09:07:36, 10] locking/locking.c:fetch_share_mode_unlocked(858)
>  fetch_share_mode_unlocked: no share_mode record around (file not open)
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates (fnum = -1) level=1004 call=5 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4299)
>  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
>[2009/06/02 09:07:36,  5] smbd/trans2.c:call_trans2qfilepathinfo(4309)
>  SMB_QFBI - create: Wed Dec 21 11:52:51 2005
>   access: Fri May 22 12:32:54 2009
>   write: Wed Dec 21 11:52:51 2005
>   change: Wed Dec 21 11:52:51 2005
>   mode: 10
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 40, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 40, paramsize = 2, datasize = 40
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=100
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44032
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=   40 (0x28)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   40 (0x28)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=45
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 80 6B BB  03 E2 05 C6 01 00 1F 90  ......k» .â.Æ....
>  [010] 5F 96 DA C9 01 80 6B BB  03 E2 05 C6 01 80 6B BB  _.ÚÉ..k» .â.Æ..k»
>  [020] 03 E2 05 C6 01 10 00 00  00 00 00 00 00           .â.Æ.... .....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 112
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x70
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2004 of length 116 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=112
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44096
>  smt_wct=15
>  smb_vwv[ 0]=   44 (0x2C)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   40 (0x28)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=   44 (0x2C)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    5 (0x5)
>  smb_bcc=47
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 EC 03 00 00 00  00 5C 00 73 00 79 00 6D  ...ì.... .\.s.y.m
>  [010] 00 62 00 6F 00 6C 00 73  00 5C 00 74 00 65 00 6D  .b.o.l.s .\.t.e.m
>  [020] 00 70 00 6C 00 61 00 74  00 65 00 73 00 00 00     .p.l.a.t .e.s...
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3943)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
>[2009/06/02 09:07:36,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "symbols/templates"
>[2009/06/02 09:07:36, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [SYMBOLS/TEMPLATES] -> [symbols/templates]
>[2009/06/02 09:07:36, 10] locking/locking.c:fetch_share_mode_unlocked(858)
>  fetch_share_mode_unlocked: no share_mode record around (file not open)
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates (fnum = -1) level=1004 call=5 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4299)
>  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
>[2009/06/02 09:07:36,  5] smbd/trans2.c:call_trans2qfilepathinfo(4309)
>  SMB_QFBI - create: Wed Dec 21 11:52:51 2005
>   access: Fri May 22 12:32:54 2009
>   write: Wed Dec 21 11:52:51 2005
>   change: Wed Dec 21 11:52:51 2005
>   mode: 10
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 40, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 40, paramsize = 2, datasize = 40
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=100
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44096
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=   40 (0x28)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   40 (0x28)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=45
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 80 6B BB  03 E2 05 C6 01 00 1F 90  ......k» .â.Æ....
>  [010] 5F 96 DA C9 01 80 6B BB  03 E2 05 C6 01 80 6B BB  _.ÚÉ..k» .â.Æ..k»
>  [020] 03 E2 05 C6 01 10 00 00  00 00 00 00 00           .â.Æ.... .....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 122
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x7a
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2005 of length 126 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=122
>  smb_com=0xa2
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44160
>  smt_wct=24
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=57054 (0xDEDE)
>  smb_vwv[ 2]= 9216 (0x2400)
>  smb_vwv[ 3]= 4096 (0x1000)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=32768 (0x8000)
>  smb_vwv[ 8]= 4096 (0x1000)
>  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]=  768 (0x300)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]=  256 (0x100)
>  smb_vwv[18]=    0 (0x0)
>  smb_vwv[19]=    0 (0x0)
>  smb_vwv[20]=    0 (0x0)
>  smb_vwv[21]=  512 (0x200)
>  smb_vwv[22]=    0 (0x0)
>  smb_vwv[23]=  768 (0x300)
>  smb_bcc=39
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 5C 00 73 00 79 00 6D  00 62 00 6F 00 6C 00 73  .\.s.y.m .b.o.l.s
>  [010] 00 5C 00 74 00 65 00 6D  00 70 00 6C 00 61 00 74  .\.t.e.m .p.l.a.t
>  [020] 00 65 00 73 00 00 00                              .e.s... 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBntcreateX (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:reply_ntcreate_and_X(454)
>  reply_ntcreate_and_X: flags = 0x10, access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 root_dir_fid = 0x0, fname = symbols/templates
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file(3283)
>  create_file: access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x(nil), fname = symbols/templates
>[2009/06/02 09:07:36,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "symbols/templates"
>[2009/06/02 09:07:36, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [SYMBOLS/TEMPLATES] -> [symbols/templates]
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file_unixpath(2889)
>  create_file_unixpath: access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 ea_list = 0x(nil), sd = 0x(nil), fname = symbols/templates
>[2009/06/02 09:07:36,  5] smbd/files.c:file_new(121)
>  allocated file structure 8642, fnum = 12738 (3 used)
>[2009/06/02 09:07:36,  3] smbd/dosmode.c:unix_mode(124)
>  unix_mode(symbols/templates) returning 0764
>[2009/06/02 09:07:36, 10] smbd/open.c:open_file_ntcreate_internal(1447)
>  open_file_ntcreate: fname=symbols/templates, dos_attrs=0x80 access_mask=0x100080 share_access=0x3 create_disposition = 0x1 create_options=0x0 unix mode=0764 oplock_request=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36, 10] smbd/open.c:open_file_ntcreate_internal(1625)
>  open_file_ntcreate: fname=symbols/templates, after mapping access_mask=0x100080
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000001300
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b250030
>[2009/06/02 09:07:36,  4] smbd/open.c:open_file_ntcreate_internal(1884)
>  calling open_file with flags=0x0 flags2=0x0 mode=0764, access_mask = 0x100080, open_access_mask = 0x100080
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:posix_get_nt_acl(3171)
>  posix_get_nt_acl: called for file symbols/templates
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2320)
>  canonicalise_acl: Access ace entries before arrange :
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 2. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:print_canon_ace_list(661)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/open.c:check_open_rights(96)
>  check_open_rights: file symbols/templates requesting 0x100080 returning 0x100000 (NT_STATUS_OK)
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000001300
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12738 (2 used)
>[2009/06/02 09:07:36,  5] smbd/open.c:open_directory(2396)
>  open_directory: opening directory symbols/templates, access_mask = 0x100080, share_access = 0x3 create_options = 0x0, create_disposition = 0x1, file_attributes = 0x80
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:posix_get_nt_acl(3171)
>  posix_get_nt_acl: called for file symbols/templates
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2320)
>  canonicalise_acl: Access ace entries before arrange :
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 2. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:print_canon_ace_list(661)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/open.c:check_open_rights(96)
>  check_open_rights: file symbols/templates requesting 0x100080 returning 0x100000 (NT_STATUS_OK)
>[2009/06/02 09:07:36,  5] smbd/files.c:file_new(121)
>  allocated file structure 8643, fnum = 12739 (3 used)
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000001300
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24f760
>[2009/06/02 09:07:36, 10] locking/locking.c:unparse_share_modes(683)
>  unparse_share_modes: del: 0, owrt: Wed 21 Dec 2005 11:52:51 WST WST cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num: 1
>[2009/06/02 09:07:36, 10] locking/locking.c:print_share_mode_table(485)
>  print_share_mode_table: share_mode_entry[0]:  pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x0, gen_id = 503, uid = 500, flags = 0, file_id fd00:1100013
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000001300
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file_unixpath(3209)
>  create_file_unixpath: info=1
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file(3477)
>  create_file: info=1
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36,  5] smbd/nttrans.c:reply_ntcreate_and_X(607)
>  reply_ntcreate_and_X: fnum = 12739, open name = symbols/templates
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=135
>  smb_com=0xa2
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44160
>  smt_wct=42
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=49920 (0xC300)
>  smb_vwv[ 3]=  305 (0x131)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=32768 (0x8000)
>  smb_vwv[ 6]=47979 (0xBB6B)
>  smb_vwv[ 7]=57859 (0xE203)
>  smb_vwv[ 8]=50693 (0xC605)
>  smb_vwv[ 9]=    1 (0x1)
>  smb_vwv[10]=36895 (0x901F)
>  smb_vwv[11]=38495 (0x965F)
>  smb_vwv[12]=51674 (0xC9DA)
>  smb_vwv[13]=32769 (0x8001)
>  smb_vwv[14]=47979 (0xBB6B)
>  smb_vwv[15]=57859 (0xE203)
>  smb_vwv[16]=50693 (0xC605)
>  smb_vwv[17]=32769 (0x8001)
>  smb_vwv[18]=47979 (0xBB6B)
>  smb_vwv[19]=57859 (0xE203)
>  smb_vwv[20]=50693 (0xC605)
>  smb_vwv[21]= 4097 (0x1001)
>  smb_vwv[22]=    0 (0x0)
>  smb_vwv[23]=    0 (0x0)
>  smb_vwv[24]=    0 (0x0)
>  smb_vwv[25]=    0 (0x0)
>  smb_vwv[26]=    0 (0x0)
>  smb_vwv[27]=    0 (0x0)
>  smb_vwv[28]=    0 (0x0)
>  smb_vwv[29]=    0 (0x0)
>  smb_vwv[30]=    0 (0x0)
>  smb_vwv[31]=    0 (0x0)
>  smb_vwv[32]= 1792 (0x700)
>  smb_vwv[33]=  256 (0x100)
>  smb_vwv[34]=    0 (0x0)
>  smb_vwv[35]=    0 (0x0)
>  smb_vwv[36]=    0 (0x0)
>  smb_vwv[37]=    0 (0x0)
>  smb_vwv[38]=    0 (0x0)
>  smb_vwv[39]=    0 (0x0)
>  smb_vwv[40]=    0 (0x0)
>  smb_vwv[41]=    0 (0x0)
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 84
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x54
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2006 of length 88 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=84
>  smb_com=0xa0
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44224
>  smt_wct=23
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  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]=   64 (0x40)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=21504 (0x5400)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    0 (0x0)
>  smb_vwv[14]=    0 (0x0)
>  smb_vwv[15]=    0 (0x0)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]= 1024 (0x400)
>  smb_vwv[18]=    2 (0x2)
>  smb_vwv[19]=  168 (0xA8)
>  smb_vwv[20]=    9 (0x9)
>  smb_vwv[21]=12739 (0x31C3)
>  smb_vwv[22]=    1 (0x1)
>  smb_bcc=3
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00                                          ... 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnttrans (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:reply_nttrans(2682)
>  reply_nttrans: state->setup_count = 8
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] A8 00 09 00 C3 31 01 00                           ¨...Ã1.. 
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1741)
>  call_nt_transact_ioctl: function[0x000900A8] FID[0x31C3] isFSctl[0x01] compfilter[0x00]
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1791)
>  FSCTL_GET_REPARSE_POINT: called on FID[0x31C3](but not implemented)
>[2009/06/02 09:07:36,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/nttrans.c(1792) cmd=160 (SMBnttrans) NT_STATUS_NOT_A_REPARSE_POINT
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0xa0
>  smb_rcls=117
>  smb_reh=2
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44224
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 41
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x29
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2007 of length 45 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  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=0
>  smb_mid=44288
>  smt_wct=3
>  smb_vwv[ 0]=12739 (0x31C3)
>  smb_vwv[ 1]=65535 (0xFFFF)
>  smb_vwv[ 2]=65535 (0xFFFF)
>  smb_bcc=0
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBclose (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/reply.c:reply_close(4343)
>  close directory fnum=12739
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000001300
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24fd60
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Wed 21 Dec 2005 11:52:51 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 1
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x0, gen_id = 503, uid = 500, flags = 0, file_id fd00:1100013
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000001300
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12739 (2 used)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x4
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=44288
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 102
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x66
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2008 of length 106 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=102
>  smb_com=0xa2
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44352
>  smt_wct=24
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=57054 (0xDEDE)
>  smb_vwv[ 2]= 4096 (0x1000)
>  smb_vwv[ 3]= 4096 (0x1000)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=32768 (0x8000)
>  smb_vwv[ 8]= 4096 (0x1000)
>  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]=  768 (0x300)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]=  256 (0x100)
>  smb_vwv[18]=    0 (0x0)
>  smb_vwv[19]=    0 (0x0)
>  smb_vwv[20]=    0 (0x0)
>  smb_vwv[21]=  512 (0x200)
>  smb_vwv[22]=    0 (0x0)
>  smb_vwv[23]=  768 (0x300)
>  smb_bcc=19
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 5C 00 73 00 79 00 6D  00 62 00 6F 00 6C 00 73  .\.s.y.m .b.o.l.s
>  [010] 00 00 00                                          ... 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBntcreateX (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:reply_ntcreate_and_X(454)
>  reply_ntcreate_and_X: flags = 0x10, access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 root_dir_fid = 0x0, fname = symbols
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file(3283)
>  create_file: access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x(nil), fname = symbols
>[2009/06/02 09:07:36,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "symbols"
>[2009/06/02 09:07:36, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [SYMBOLS] -> [symbols]
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file_unixpath(2889)
>  create_file_unixpath: access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 ea_list = 0x(nil), sd = 0x(nil), fname = symbols
>[2009/06/02 09:07:36,  5] smbd/files.c:file_new(121)
>  allocated file structure 8644, fnum = 12740 (3 used)
>[2009/06/02 09:07:36,  3] smbd/dosmode.c:unix_mode(124)
>  unix_mode(symbols) returning 0764
>[2009/06/02 09:07:36, 10] smbd/open.c:open_file_ntcreate_internal(1447)
>  open_file_ntcreate: fname=symbols, dos_attrs=0x80 access_mask=0x100080 share_access=0x3 create_disposition = 0x1 create_options=0x0 unix mode=0764 oplock_request=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36, 10] smbd/open.c:open_file_ntcreate_internal(1625)
>  open_file_ntcreate: fname=symbols, after mapping access_mask=0x100080
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000001200
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24ffb0
>[2009/06/02 09:07:36,  4] smbd/open.c:open_file_ntcreate_internal(1884)
>  calling open_file with flags=0x0 flags2=0x0 mode=0764, access_mask = 0x100080, open_access_mask = 0x100080
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:posix_get_nt_acl(3171)
>  posix_get_nt_acl: called for file symbols
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2320)
>  canonicalise_acl: Access ace entries before arrange :
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 2. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:print_canon_ace_list(661)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/open.c:check_open_rights(96)
>  check_open_rights: file symbols requesting 0x100080 returning 0x100000 (NT_STATUS_OK)
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000001200
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12740 (2 used)
>[2009/06/02 09:07:36,  5] smbd/open.c:open_directory(2396)
>  open_directory: opening directory symbols, access_mask = 0x100080, share_access = 0x3 create_options = 0x0, create_disposition = 0x1, file_attributes = 0x80
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:posix_get_nt_acl(3171)
>  posix_get_nt_acl: called for file symbols
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2320)
>  canonicalise_acl: Access ace entries before arrange :
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 2. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:print_canon_ace_list(661)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms r-x
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms r-x
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9
>[2009/06/02 09:07:36, 10] smbd/open.c:check_open_rights(96)
>  check_open_rights: file symbols requesting 0x100080 returning 0x100000 (NT_STATUS_OK)
>[2009/06/02 09:07:36,  5] smbd/files.c:file_new(121)
>  allocated file structure 8645, fnum = 12741 (3 used)
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000001200
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b239150
>[2009/06/02 09:07:36, 10] locking/locking.c:unparse_share_modes(683)
>  unparse_share_modes: del: 0, owrt: Fri 09 Jan 2009 07:25:30 WST WST cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num: 1
>[2009/06/02 09:07:36, 10] locking/locking.c:print_share_mode_table(485)
>  print_share_mode_table: share_mode_entry[0]:  pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x0, gen_id = 505, uid = 500, flags = 0, file_id fd00:1100012
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000001200
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file_unixpath(3209)
>  create_file_unixpath: info=1
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file(3477)
>  create_file: info=1
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36,  5] smbd/nttrans.c:reply_ntcreate_and_X(607)
>  reply_ntcreate_and_X: fnum = 12741, open name = symbols
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=135
>  smb_com=0xa2
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44352
>  smt_wct=42
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=50432 (0xC500)
>  smb_vwv[ 3]=  305 (0x131)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]= 9297 (0x2451)
>  smb_vwv[ 7]=59493 (0xE865)
>  smb_vwv[ 8]=51569 (0xC971)
>  smb_vwv[ 9]=    1 (0x1)
>  smb_vwv[10]=36895 (0x901F)
>  smb_vwv[11]=38495 (0x965F)
>  smb_vwv[12]=51674 (0xC9DA)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]= 9297 (0x2451)
>  smb_vwv[15]=59493 (0xE865)
>  smb_vwv[16]=51569 (0xC971)
>  smb_vwv[17]=    1 (0x1)
>  smb_vwv[18]= 9297 (0x2451)
>  smb_vwv[19]=59493 (0xE865)
>  smb_vwv[20]=51569 (0xC971)
>  smb_vwv[21]= 4097 (0x1001)
>  smb_vwv[22]=    0 (0x0)
>  smb_vwv[23]=    0 (0x0)
>  smb_vwv[24]=    0 (0x0)
>  smb_vwv[25]=    0 (0x0)
>  smb_vwv[26]=    0 (0x0)
>  smb_vwv[27]=    0 (0x0)
>  smb_vwv[28]=    0 (0x0)
>  smb_vwv[29]=    0 (0x0)
>  smb_vwv[30]=    0 (0x0)
>  smb_vwv[31]=    0 (0x0)
>  smb_vwv[32]= 1792 (0x700)
>  smb_vwv[33]=  256 (0x100)
>  smb_vwv[34]=    0 (0x0)
>  smb_vwv[35]=    0 (0x0)
>  smb_vwv[36]=    0 (0x0)
>  smb_vwv[37]=    0 (0x0)
>  smb_vwv[38]=    0 (0x0)
>  smb_vwv[39]=    0 (0x0)
>  smb_vwv[40]=    0 (0x0)
>  smb_vwv[41]=    0 (0x0)
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 84
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x54
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2009 of length 88 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=84
>  smb_com=0xa0
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44416
>  smt_wct=23
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  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]=   64 (0x40)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=21504 (0x5400)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    0 (0x0)
>  smb_vwv[14]=    0 (0x0)
>  smb_vwv[15]=    0 (0x0)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]= 1024 (0x400)
>  smb_vwv[18]=    2 (0x2)
>  smb_vwv[19]=  168 (0xA8)
>  smb_vwv[20]=    9 (0x9)
>  smb_vwv[21]=12741 (0x31C5)
>  smb_vwv[22]=    1 (0x1)
>  smb_bcc=3
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00                                          ... 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnttrans (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:reply_nttrans(2682)
>  reply_nttrans: state->setup_count = 8
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] A8 00 09 00 C5 31 01 00                           ¨...Å1.. 
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1741)
>  call_nt_transact_ioctl: function[0x000900A8] FID[0x31C5] isFSctl[0x01] compfilter[0x00]
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1791)
>  FSCTL_GET_REPARSE_POINT: called on FID[0x31C5](but not implemented)
>[2009/06/02 09:07:36,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/nttrans.c(1792) cmd=160 (SMBnttrans) NT_STATUS_NOT_A_REPARSE_POINT
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0xa0
>  smb_rcls=117
>  smb_reh=2
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44416
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 41
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x29
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2010 of length 45 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  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=0
>  smb_mid=44480
>  smt_wct=3
>  smb_vwv[ 0]=12741 (0x31C5)
>  smb_vwv[ 1]=65535 (0xFFFF)
>  smb_vwv[ 2]=65535 (0xFFFF)
>  smb_bcc=0
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBclose (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/reply.c:reply_close(4343)
>  close directory fnum=12741
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000001200
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24fd60
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Fri 09 Jan 2009 07:25:30 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 1
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x0, gen_id = 505, uid = 500, flags = 0, file_id fd00:1100012
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000001200
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12741 (2 used)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x4
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=44480
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 88
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x58
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2011 of length 92 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=88
>  smb_com=0xa2
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44544
>  smt_wct=24
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=57054 (0xDEDE)
>  smb_vwv[ 2]=  512 (0x200)
>  smb_vwv[ 3]= 4096 (0x1000)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=32768 (0x8000)
>  smb_vwv[ 8]= 4096 (0x1000)
>  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]=  768 (0x300)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]=  256 (0x100)
>  smb_vwv[18]=    0 (0x0)
>  smb_vwv[19]=    0 (0x0)
>  smb_vwv[20]=    0 (0x0)
>  smb_vwv[21]=  512 (0x200)
>  smb_vwv[22]=    0 (0x0)
>  smb_vwv[23]=  768 (0x300)
>  smb_bcc=5
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 5C 00 00 00                                    .\... 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBntcreateX (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:reply_ntcreate_and_X(454)
>  reply_ntcreate_and_X: flags = 0x10, access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 root_dir_fid = 0x0, fname = 
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file(3283)
>  create_file: access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x(nil), fname = 
>[2009/06/02 09:07:36,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file ""
>[2009/06/02 09:07:36,  5] smbd/filename.c:unix_convert(184)
>  conversion finished "" -> .
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file_unixpath(2889)
>  create_file_unixpath: access_mask = 0x100080 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x1 create_options = 0x0 oplock_request = 0x0 ea_list = 0x(nil), sd = 0x(nil), fname = .
>[2009/06/02 09:07:36,  5] smbd/files.c:file_new(121)
>  allocated file structure 8646, fnum = 12742 (3 used)
>[2009/06/02 09:07:36,  3] smbd/dosmode.c:unix_mode(124)
>  unix_mode(.) returning 0764
>[2009/06/02 09:07:36, 10] smbd/open.c:open_file_ntcreate_internal(1447)
>  open_file_ntcreate: fname=., dos_attrs=0x80 access_mask=0x100080 share_access=0x3 create_disposition = 0x1 create_options=0x0 unix mode=0764 oplock_request=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: .
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36, 10] smbd/open.c:open_file_ntcreate_internal(1625)
>  open_file_ntcreate: fname=., after mapping access_mask=0x100080
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000000100
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24feb0
>[2009/06/02 09:07:36,  4] smbd/open.c:open_file_ntcreate_internal(1884)
>  calling open_file with flags=0x0 flags2=0x0 mode=0764, access_mask = 0x100080, open_access_mask = 0x100080
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:posix_get_nt_acl(3171)
>  posix_get_nt_acl: called for file .
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2320)
>  canonicalise_acl: Access ace entries before arrange :
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 2. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:print_canon_ace_list(661)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/open.c:check_open_rights(96)
>  check_open_rights: file . requesting 0x100080 returning 0x100000 (NT_STATUS_OK)
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000000100
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12742 (2 used)
>[2009/06/02 09:07:36,  5] smbd/open.c:open_directory(2396)
>  open_directory: opening directory ., access_mask = 0x100080, share_access = 0x3 create_options = 0x0, create_disposition = 0x1, file_attributes = 0x80
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:posix_get_nt_acl(3171)
>  posix_get_nt_acl: called for file .
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2320)
>  canonicalise_acl: Access ace entries before arrange :
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:canonicalise_acl(2333)
>  canon_ace index 2. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:print_canon_ace_list(661)
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange
>  canon_ace index 0. Type = allow SID = S-1-22-1-500 uid 500 (enmac) SMB_ACL_USER_OBJ perms rwx
>  canon_ace index 1. Type = allow SID = S-1-22-2-500 gid 500 (enmac) SMB_ACL_GROUP_OBJ perms rwx
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER perms rwx
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/posix_acls.c:map_canon_ace_perms(936)
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff
>[2009/06/02 09:07:36, 10] smbd/open.c:check_open_rights(96)
>  check_open_rights: file . requesting 0x100080 returning 0x100000 (NT_STATUS_OK)
>[2009/06/02 09:07:36,  5] smbd/files.c:file_new(121)
>  allocated file structure 8647, fnum = 12743 (3 used)
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000000100
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b251a40
>[2009/06/02 09:07:36, 10] locking/locking.c:unparse_share_modes(683)
>  unparse_share_modes: del: 0, owrt: Wed 15 Apr 2009 14:28:16 WST WST cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num: 1
>[2009/06/02 09:07:36, 10] locking/locking.c:print_share_mode_table(485)
>  print_share_mode_table: share_mode_entry[0]:  pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x0, gen_id = 507, uid = 500, flags = 0, file_id fd00:1100001
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000000100
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file_unixpath(3209)
>  create_file_unixpath: info=1
>[2009/06/02 09:07:36, 10] smbd/open.c:create_file(3477)
>  create_file: info=1
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: .
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning d
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning d
>[2009/06/02 09:07:36,  5] smbd/nttrans.c:reply_ntcreate_and_X(607)
>  reply_ntcreate_and_X: fnum = 12743, open name = .
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=135
>  smb_com=0xa2
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44544
>  smt_wct=42
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=50944 (0xC700)
>  smb_vwv[ 3]=  305 (0x131)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]= 7360 (0x1CC0)
>  smb_vwv[ 7]=37724 (0x935C)
>  smb_vwv[ 8]=51645 (0xC9BD)
>  smb_vwv[ 9]=    1 (0x1)
>  smb_vwv[10]=19679 (0x4CDF)
>  smb_vwv[11]= 7677 (0x1DFD)
>  smb_vwv[12]=51683 (0xC9E3)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]= 7360 (0x1CC0)
>  smb_vwv[15]=37724 (0x935C)
>  smb_vwv[16]=51645 (0xC9BD)
>  smb_vwv[17]=    1 (0x1)
>  smb_vwv[18]= 7360 (0x1CC0)
>  smb_vwv[19]=37724 (0x935C)
>  smb_vwv[20]=51645 (0xC9BD)
>  smb_vwv[21]= 4097 (0x1001)
>  smb_vwv[22]=    0 (0x0)
>  smb_vwv[23]=    0 (0x0)
>  smb_vwv[24]=    0 (0x0)
>  smb_vwv[25]=    0 (0x0)
>  smb_vwv[26]=    0 (0x0)
>  smb_vwv[27]=    0 (0x0)
>  smb_vwv[28]=    0 (0x0)
>  smb_vwv[29]=    0 (0x0)
>  smb_vwv[30]=    0 (0x0)
>  smb_vwv[31]=    0 (0x0)
>  smb_vwv[32]= 1792 (0x700)
>  smb_vwv[33]=  256 (0x100)
>  smb_vwv[34]=    0 (0x0)
>  smb_vwv[35]=    0 (0x0)
>  smb_vwv[36]=    0 (0x0)
>  smb_vwv[37]=    0 (0x0)
>  smb_vwv[38]=    0 (0x0)
>  smb_vwv[39]=    0 (0x0)
>  smb_vwv[40]=    0 (0x0)
>  smb_vwv[41]=    0 (0x0)
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 84
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x54
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2012 of length 88 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=84
>  smb_com=0xa0
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44608
>  smt_wct=23
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  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]=   64 (0x40)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=21504 (0x5400)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    0 (0x0)
>  smb_vwv[14]=    0 (0x0)
>  smb_vwv[15]=    0 (0x0)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]= 1024 (0x400)
>  smb_vwv[18]=    2 (0x2)
>  smb_vwv[19]=  168 (0xA8)
>  smb_vwv[20]=    9 (0x9)
>  smb_vwv[21]=12743 (0x31C7)
>  smb_vwv[22]=    1 (0x1)
>  smb_bcc=3
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00                                          ... 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnttrans (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:reply_nttrans(2682)
>  reply_nttrans: state->setup_count = 8
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] A8 00 09 00 C7 31 01 00                           ¨...Ç1.. 
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1741)
>  call_nt_transact_ioctl: function[0x000900A8] FID[0x31C7] isFSctl[0x01] compfilter[0x00]
>[2009/06/02 09:07:36, 10] smbd/nttrans.c:call_nt_transact_ioctl(1791)
>  FSCTL_GET_REPARSE_POINT: called on FID[0x31C7](but not implemented)
>[2009/06/02 09:07:36,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/nttrans.c(1792) cmd=160 (SMBnttrans) NT_STATUS_NOT_A_REPARSE_POINT
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0xa0
>  smb_rcls=117
>  smb_reh=2
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44608
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 41
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x29
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2013 of length 45 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  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=0
>  smb_mid=44672
>  smt_wct=3
>  smb_vwv[ 0]=12743 (0x31C7)
>  smb_vwv[ 1]=65535 (0xFFFF)
>  smb_vwv[ 2]=65535 (0xFFFF)
>  smb_bcc=0
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBclose (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/reply.c:reply_close(4343)
>  close directory fnum=12743
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000000100
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24fd60
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Wed 15 Apr 2009 14:28:16 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 1
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x0, gen_id = 507, uid = 500, flags = 0, file_id fd00:1100001
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000000100
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12743 (2 used)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x4
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=44672
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 41
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x29
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2014 of length 45 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  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=0
>  smb_mid=44736
>  smt_wct=3
>  smb_vwv[ 0]=12732 (0x31BC)
>  smb_vwv[ 1]=65535 (0xFFFF)
>  smb_vwv[ 2]=65535 (0xFFFF)
>  smb_bcc=0
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBclose (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/reply.c:reply_close(4353)
>  close fd=-1 fnum=12732 (numopen=2)
>[2009/06/02 09:07:36,  6] smbd/close.c:set_close_write_time(450)
>  close_write_time: Sun Feb  7 14:28:15 2106
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD00000000000077C0
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24fd60
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]:  pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x10, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:unparse_share_modes(683)
>  unparse_share_modes: del: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:print_share_mode_table(485)
>  print_share_mode_table: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:print_share_mode_table(485)
>  print_share_mode_table: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:print_share_mode_table(485)
>  print_share_mode_table: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD00000000000077C0
>[2009/06/02 09:07:36,  2] smbd/close.c:close_normal_file(606)
>  enmac closed file symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (numopen=1) NT_STATUS_OK
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12732 (1 used)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x4
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=44736
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 59
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x3b
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2015 of length 63 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=59
>  smb_com=0x2e
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=44800
>  smt_wct=12
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=57054 (0xDEDE)
>  smb_vwv[ 2]=12717 (0x31AD)
>  smb_vwv[ 3]=    0 (0x0)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=  349 (0x15D)
>  smb_vwv[ 6]=  349 (0x15D)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=  349 (0x15D)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=    0 (0x0)
>  smb_bcc=0
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBreadX (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD00000000000077C0
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24fd30
>[2009/06/02 09:07:36, 10] locking/brlock.c:brl_get_locks_internal(1683)
>  brl_get_locks_internal: 0 current locks on file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/posix.c:is_posix_locked(284)
>  is_posix_locked: File symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out, offset = 0, count = 349, type = READ
>[2009/06/02 09:07:36, 10] locking/posix.c:posix_lock_in_range(172)
>  posix_lock_in_range: offset_out = 0, count_out = 349
>[2009/06/02 09:07:36,  8] locking/posix.c:posix_fcntl_getlock(234)
>  posix_fcntl_getlock 24 0 349 0
>[2009/06/02 09:07:36,  8] lib/util.c:fcntl_getlock(2061)
>  fcntl_getlock fd=24 offset=0 count=349 type=0
>[2009/06/02 09:07:36,  3] lib/util.c:fcntl_getlock(2085)
>  fcntl_getlock: fd 24 is returned info 2 pid 0
>[2009/06/02 09:07:36,  8] locking/posix.c:posix_fcntl_getlock(264)
>  posix_fcntl_getlock: Lock query call successful
>[2009/06/02 09:07:36, 10] locking/brlock.c:brl_locktest(1135)
>  brl_locktest: posix start=0 len=349 unlocked for fnum 12717 file symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD00000000000077C0
>[2009/06/02 09:07:36, 10] locking/locking.c:is_locked(136)
>  is_locked: flavour = WINDOWS_LOCK brl start=0 len=349 unlocked for fnum 12717 file symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36, 10] smbd/fileio.c:read_file(104)
>  read_file (symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out): pos = 0, size = 349, returned 349
>[2009/06/02 09:07:36,  3] smbd/reply.c:send_file_readX(3327)
>  send_file_readX fnum=12717 max=349 nread=349
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=408
>  smb_com=0x2e
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=44800
>  smt_wct=12
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=65535 (0xFFFF)
>  smb_vwv[ 3]=    0 (0x0)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=  349 (0x15D)
>  smb_vwv[ 6]=   59 (0x3B)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=    0 (0x0)
>  smb_bcc=349
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 1F 8B 08 10 00 00 00 00  00 03 45 4E 4D 41 43 31  ........ ..ENMAC1
>  [010] 00 63 60 00 02 16 06 46  10 C5 C0 C5 20 CA C0 1A  .c`....F .ÅÀÅ ÊÀ.
>  [020] 36 C5 D3 71 41 81 27 E7  BD 04 20 7D 00 4A 4F 00  6ÅÓqA.'ç ½. }.JO.
>  [030] D1 0C 03 0D D8 2B 75 90  B9 21 98 2A 64 31 44 30  Ñ...Ø+u. ¹!.*d1D0
>  [040] FD 06 F2 4B 04 9A DF 32  30 F4 D1 1B 50 C7 6F 1F  ý.òK..ß2 0ôÑ.PÇo.
>  [050] D0 FC F6 61 F8 F8 6D A1  00 5A 9A FC 30 64 D3 24  Ðüöaøøm¡ .Z.ü0dÓ$
>  [060] 2B D4 6F 7C F0 78 3B 80  EC 37 FB 06 06 06 10 06  +Ôo|ðx;. ì7û.....
>  [070] 81 F2 82 64 FD 92 D4 DC  82 9C C4 92 D4 62 20 AB  .ò.dý.ÔÜ ..Ä.Ôb «
>  [080] B8 24 1E C1 55 56 CE 2E  8B 4F 2B 2D 4E 8D 2F 2E  ¸$.ÁUVÎ. .O+-N./.
>  [090] CF 2C 49 1E F8 88 06 02  76 84 DF FE 03 01 DC 6F  Ï,I.ø... v.ßþ..Üo
>  [0A0] 0E 3F 18 3C 39 5D 08 68  1E E4 80 03 EA 37 21 78  .?.<9].h .ä..ê7!x
>  [0B0] BC CD 00 FA 2D 00 E6 47  06 D6 36 57 B0 18 04 BF  ¼Í.ú-.æG .Ö6W°..¿
>  [0C0] 80 E2 19 04 4C 45 01 60  F3 38 EF 15 20 D3 84 F4  .â..LE.` ó8ï. Ó.ô
>  [0D0] 50 05 30 C3 F3 9B 04 8E  3A 20 02 48 7B 00 E9 0E  P.0Ãó... : .H{.é.
>  [0E0] 20 5D 01 54 C9 18 62 60  60 90 62 69 69 9A E4 E1   ].TÉ.b` `.bii.äá
>  [0F0] 0F 4C F6 20 9E A9 A1 59  72 9A B3 BF 6F 00 83 73  .Lö .©¡Y r.³¿o..s
>  [100] 7E 5E 5E 6A 72 49 66 7E  9E 42 40 7E 66 5E 09 2E  ~^^jrIf~ .B@~f^..
>  [110] 6B 91 D3 3A CD 00 A6 DF  0E A0 F9 0D 54 07 18 40  k.Ó:Í.¦ß . ù.T..@
>  [120] CB 94 09 0C 48 7E 4B 46  F1 5B 2A D8 6F 6E C0 1C  Ë...H~KF ñ[*ØonÀ.
>  [130] A7 A0 E1 52 94 5F A0 E0  5F 5A A2 89 D3 DA 81 F1  § áR._ à _Z¢.ÓÚ.ñ
>  [140] 1B 46 39 F9 03 12 6F 0B  35 D0 E3 2D 05 D9 6F 29  .F9ù..o. 5Ðã-.Ùo)
>  [150] 86 83 2A DE 00 F4 60 8F  34 98 08 00 00           ..*Þ.ô`. 4....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 72
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x48
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2016 of length 76 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=72
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44864
>  smt_wct=15
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=  104 (0x68)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    4 (0x4)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    7 (0x7)
>  smb_bcc=7
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 AD 31 EC 03                              ...1ì. 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3867)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1004
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (fnum = 12717) level=1004 call=7 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning 
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning 
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4299)
>  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
>[2009/06/02 09:07:36,  5] smbd/trans2.c:call_trans2qfilepathinfo(4309)
>  SMB_QFBI - create: Tue Jan 27 12:58:25 2004
>   access: Tue Jun  2 09:07:36 2009
>   write: Tue Jan 27 12:58:25 2004
>   change: Tue Jan 27 12:58:25 2004
>   mode: 80
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 40, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 40, paramsize = 2, datasize = 40
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=100
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44864
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=   40 (0x28)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   40 (0x28)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=45
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 80 AE E5  31 92 E4 C3 01 00 BC 01  ......®å 1.äÃ..¼.
>  [010] 84 1E E3 C9 01 80 AE E5  31 92 E4 C3 01 80 AE E5  ..ãÉ..®å 1.äÃ..®å
>  [020] 31 92 E4 C3 01 80 00 00  00 00 00 00 00           1.äÃ.... .....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 72
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x48
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2017 of length 76 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=72
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44928
>  smt_wct=15
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   64 (0x40)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    4 (0x4)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    7 (0x7)
>  smb_bcc=7
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 AD 31 ED 03                              ...1í. 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3867)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1005
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (fnum = 12717) level=1005 call=7 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning 
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning 
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4320)
>  call_trans2qfilepathinfo: SMB_FILE_STANDARD_INFORMATION
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 24, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 24, paramsize = 2, datasize = 24
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=84
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44928
>  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
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 00 00 10  00 00 00 00 00 5D 01 00  ........ .....]..
>  [010] 00 00 00 00 00 01 00 00  00 00 00 00 00           ........ .....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 72
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x48
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2018 of length 76 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=72
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44992
>  smt_wct=15
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   32 (0x20)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    4 (0x4)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    7 (0x7)
>  smb_bcc=7
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 AD 31 EF 03                              ...1ï. 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3867)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1007
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (fnum = 12717) level=1007 call=7 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning 
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning 
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4334)
>  call_trans2qfilepathinfo: SMB_FILE_EA_INFORMATION
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 4, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 4, paramsize = 2, datasize = 4
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=64
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=44992
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=    4 (0x4)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    4 (0x4)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=9
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 00 00 00  00                       ........ .
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 72
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x48
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2019 of length 76 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=72
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45056
>  smt_wct=15
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=  104 (0x68)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    4 (0x4)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    7 (0x7)
>  smb_bcc=7
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 AD 31 EC 03                              ...1ì. 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3867)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1004
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (fnum = 12717) level=1004 call=7 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning 
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning 
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4299)
>  call_trans2qfilepathinfo: SMB_FILE_BASIC_INFORMATION
>[2009/06/02 09:07:36,  5] smbd/trans2.c:call_trans2qfilepathinfo(4309)
>  SMB_QFBI - create: Tue Jan 27 12:58:25 2004
>   access: Tue Jun  2 09:07:36 2009
>   write: Tue Jan 27 12:58:25 2004
>   change: Tue Jan 27 12:58:25 2004
>   mode: 80
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 40, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 40, paramsize = 2, datasize = 40
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=100
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45056
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=   40 (0x28)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=   40 (0x28)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=45
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 80 AE E5  31 92 E4 C3 01 00 BC 01  ......®å 1.äÃ..¼.
>  [010] 84 1E E3 C9 01 80 AE E5  31 92 E4 C3 01 80 AE E5  ..ãÉ..®å 1.äÃ..®å
>  [020] 31 92 E4 C3 01 80 00 00  00 00 00 00 00           1.äÃ.... .....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 72
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x48
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2020 of length 76 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=72
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45120
>  smt_wct=15
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   64 (0x40)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    4 (0x4)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    7 (0x7)
>  smb_bcc=7
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 AD 31 ED 03                              ...1í. 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3867)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1005
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (fnum = 12717) level=1005 call=7 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning 
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning 
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4320)
>  call_trans2qfilepathinfo: SMB_FILE_STANDARD_INFORMATION
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 24, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 24, paramsize = 2, datasize = 24
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=84
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45120
>  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
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 00 00 10  00 00 00 00 00 5D 01 00  ........ .....]..
>  [010] 00 00 00 00 00 01 00 00  00 00 00 00 00           ........ .....
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 72
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x48
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2021 of length 76 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=72
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45184
>  smt_wct=15
>  smb_vwv[ 0]=    4 (0x4)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   32 (0x20)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    4 (0x4)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    7 (0x7)
>  smb_bcc=7
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 AD 31 EF 03                              ...1ï. 
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(3867)
>  call_trans2qfilepathinfo: TRANSACT2_QFILEINFO: level = 1007
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36,  3] smbd/trans2.c:call_trans2qfilepathinfo(4057)
>  call_trans2qfilepathinfo symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (fnum = 12717) level=1007 call=7 total_data=0
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning 
>[2009/06/02 09:07:36,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning 
>[2009/06/02 09:07:36, 10] smbd/trans2.c:call_trans2qfilepathinfo(4334)
>  call_trans2qfilepathinfo: SMB_FILE_EA_INFORMATION
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(840)
>  t2_rep: params_sent_thistime = 2, data_sent_thistime = 4, useable_space = 65473
>[2009/06/02 09:07:36,  9] smbd/trans2.c:send_trans2_replies(842)
>  t2_rep: params_to_send = 2, data_to_send = 4, paramsize = 2, datasize = 4
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=64
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45184
>  smt_wct=10
>  smb_vwv[ 0]=    2 (0x2)
>  smb_vwv[ 1]=    4 (0x4)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=    2 (0x2)
>  smb_vwv[ 4]=   56 (0x38)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    4 (0x4)
>  smb_vwv[ 7]=   60 (0x3C)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_bcc=9
>[2009/06/02 09:07:36, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 00 00 00 00 00  00                       ........ .
>[2009/06/02 09:07:36, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 41
>[2009/06/02 09:07:36,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x29
>[2009/06/02 09:07:36,  3] smbd/process.c:process_smb(1554)
>  Transaction 2022 of length 45 (0 toread)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  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=0
>  smb_mid=45248
>  smt_wct=3
>  smb_vwv[ 0]=12717 (0x31AD)
>  smb_vwv[ 1]=65535 (0xFFFF)
>  smb_vwv[ 2]=65535 (0xFFFF)
>  smb_bcc=0
>[2009/06/02 09:07:36,  3] smbd/process.c:switch_message(1378)
>  switch message SMBclose (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:36,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:36,  3] smbd/reply.c:reply_close(4353)
>  close fd=24 fnum=12717 (numopen=1)
>[2009/06/02 09:07:36,  6] smbd/close.c:set_close_write_time(450)
>  close_write_time: Sun Feb  7 14:28:15 2106
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD00000000000077C0
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b24fd60
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 27 Jan 2004 12:58:25 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 3
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120089, mid = 0x0, type= 0x10, gen_id = 481, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[1]: UNUSED pid = 6218, share_access = 0x7, private_options = 0x0, access_mask = 0x120080, mid = 0x0, type= 0x40, gen_id = 496, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[2]: UNUSED pid = 6218, share_access = 0x3, private_options = 0x0, access_mask = 0x100080, mid = 0x0, type= 0x40, gen_id = 497, uid = 500, flags = 0, file_id fd00:6ac077
>[2009/06/02 09:07:36, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD00000000000077C0
>[2009/06/02 09:07:36, 10] locking/posix.c:get_windows_lock_ref_count(495)
>  get_windows_lock_count for file symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out = 0
>[2009/06/02 09:07:36, 10] locking/posix.c:delete_windows_lock_ref_count(521)
>  delete_windows_lock_ref_count for file symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out
>[2009/06/02 09:07:36,  2] smbd/close.c:close_normal_file(606)
>  enmac closed file symbols/templates/primary_assets_equipment/switching_equipment/tplt_fuse_drop_out (numopen=0) NT_STATUS_OK
>[2009/06/02 09:07:36,  5] smbd/files.c:file_free(471)
>  freed files structure 12717 (0 used)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:36,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x4
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=45248
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:58, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 122
>[2009/06/02 09:07:58,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x7a
>[2009/06/02 09:07:58,  3] smbd/process.c:process_smb(1554)
>  Transaction 2023 of length 126 (0 toread)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=122
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45312
>  smt_wct=15
>  smb_vwv[ 0]=   54 (0x36)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   40 (0x28)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=   54 (0x36)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    5 (0x5)
>  smb_bcc=57
>[2009/06/02 09:07:58, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 EC 03 00 00 00  00 5C 00 6D 00 69 00 73  ...ì.... .\.m.i.s
>  [010] 00 63 00 5C 00 74 00 6D  00 70 00 5C 00 43 00 30  .c.\.t.m .p.\.C.0
>  [020] 00 30 00 30 00 30 00 30  00 30 00 64 00 64 00 46  .0.0.0.0 .0.d.d.F
>  [030] 00 49 00 4C 00 45 00 00  00                       .I.L.E.. .
>[2009/06/02 09:07:58,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:58,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:58,  3] smbd/trans2.c:call_trans2qfilepathinfo(3943)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "misc/tmp/C000000ddFILE"
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(235)
>  stat_cache_lookup: lookup failed for name [MISC/TMP/C000000DDFILE]
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [MISC/TMP] -> [misc/tmp]
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(306)
>  unix_convert begin: name = misc/tmp/C000000ddFILE, dirpath = misc/tmp, start = C000000ddFILE
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(562)
>  New file C000000ddFILE
>[2009/06/02 09:07:58,  3] smbd/trans2.c:call_trans2qfilepathinfo(4037)
>  call_trans2qfilepathinfo: SMB_VFS_STAT of misc/tmp/C000000ddFILE failed (No such file or directory)
>[2009/06/02 09:07:58,  3] smbd/error.c:reply_unix_error(154)
>  unix_error_packet: error string = No such file or directory
>[2009/06/02 09:07:58,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/trans2.c(4038) cmd=50 (SMBtrans2) NT_STATUS_OBJECT_NAME_NOT_FOUND
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x32
>  smb_rcls=52
>  smb_reh=0
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45312
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:58, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 376
>[2009/06/02 09:07:58,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x178
>[2009/06/02 09:07:58,  3] smbd/process.c:process_smb(1554)
>  Transaction 2024 of length 380 (0 toread)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=376
>  smb_com=0xa0
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45376
>  smt_wct=19
>  smb_vwv[ 0]=    0 (0x0)
>  smb_vwv[ 1]=25600 (0x6400)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=51200 (0xC800)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=25856 (0x6500)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=25600 (0x6400)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=19456 (0x4C00)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=51200 (0xC800)
>  smb_vwv[14]=    0 (0x0)
>  smb_vwv[15]=45056 (0xB000)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]=    0 (0x0)
>  smb_vwv[18]=    1 (0x1)
>  smb_bcc=303
>[2009/06/02 09:07:58, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 10 00 00 00 00  00 00 00 9F 01 12 00 00  ........ ........
>  [010] 00 00 00 00 00 00 00 00  00 00 00 07 00 00 00 01  ........ ........
>  [020] 00 00 00 40 00 00 00 C8  00 00 00 00 00 00 00 2E  ...@...È ........
>  [030] 00 00 00 02 00 00 00 03  00 5C 00 6D 00 69 00 73  ........ .\.m.i.s
>  [040] 00 63 00 5C 00 74 00 6D  00 70 00 5C 00 43 00 30  .c.\.t.m .p.\.C.0
>  [050] 00 30 00 30 00 30 00 30  00 30 00 64 00 64 00 46  .0.0.0.0 .0.d.d.F
>  [060] 00 49 00 4C 00 45 00 01  00 04 80 90 00 00 00 AC  .I.L.E.. .......¬
>  [070] 00 00 00 00 00 00 00 14  00 00 00 02 00 7C 00 04  ........ .....|..
>  [080] 00 00 00 00 00 24 00 FF  01 1F 00 01 05 00 00 00  .....$.ÿ ........
>  [090] 00 00 05 15 00 00 00 EE  94 02 07 FF 13 98 15 43  .......î ...ÿ...C
>  [0A0] 17 0A 32 F4 01 00 00 00  00 24 00 A9 00 12 00 01  ..2ô.... .$.©....
>  [0B0] 05 00 00 00 00 00 05 15  00 00 00 EE 94 02 07 FF  ........ ...î...ÿ
>  [0C0] 13 98 15 43 17 0A 32 01  02 00 00 00 00 14 00 A9  ...C..2. .......©
>  [0D0] 00 12 00 01 01 00 00 00  00 00 01 00 00 00 00 00  ........ ........
>  [0E0] 00 18 00 FF 01 1F 00 01  02 00 00 00 00 00 05 20  ...ÿ.... ....... 
>  [0F0] 00 00 00 20 02 00 00 01  05 00 00 00 00 00 05 15  ... .... ........
>  [100] 00 00 00 EE 94 02 07 FF  13 98 15 43 17 0A 32 F4  ...î...ÿ ...C..2ô
>  [110] 01 00 00 01 05 00 00 00  00 00 05 15 00 00 00 EE  ........ .......î
>  [120] 94 02 07 FF 13 98 15 43  17 0A 32 01 02 00 00     ...ÿ...C ..2....
>[2009/06/02 09:07:58,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnttrans (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:58,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:58,  5] smbd/nttrans.c:call_nt_transact_create(826)
>  call_nt_transact_create
>[2009/06/02 09:07:58, 10] smbd/nttrans.c:call_nt_transact_create(888)
>  call_nt_transact_create - sd_len = 200
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file(3283)
>  create_file: access_mask = 0x12019f file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x40 oplock_request = 0x0 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x0x552b24fdf0, fname = misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "misc/tmp/C000000ddFILE"
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(235)
>  stat_cache_lookup: lookup failed for name [MISC/TMP/C000000DDFILE]
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [MISC/TMP] -> [misc/tmp]
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(306)
>  unix_convert begin: name = misc/tmp/C000000ddFILE, dirpath = misc/tmp, start = C000000ddFILE
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(562)
>  New file C000000ddFILE
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file_unixpath(2889)
>  create_file_unixpath: access_mask = 0x12019f file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x40 oplock_request = 0x0 ea_list = 0x(nil), sd = 0x0x552b24fdf0, fname = misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  5] smbd/files.c:file_new(121)
>  allocated file structure 8648, fnum = 12744 (1 used)
>[2009/06/02 09:07:58,  3] smbd/dosmode.c:unix_mode(124)
>  unix_mode(misc/tmp/C000000ddFILE) returning 0764
>[2009/06/02 09:07:58, 10] smbd/open.c:open_file_ntcreate_internal(1447)
>  open_file_ntcreate: fname=misc/tmp/C000000ddFILE, dos_attrs=0x0 access_mask=0x12019f share_access=0x7 create_disposition = 0x1 create_options=0x40 unix mode=0764 oplock_request=0
>[2009/06/02 09:07:58,  5] smbd/open.c:open_file_ntcreate_internal(1540)
>  open_file_ntcreate: FILE_OPEN requested for file misc/tmp/C000000ddFILE and file doesn't exist.
>[2009/06/02 09:07:58,  5] smbd/files.c:file_free(471)
>  freed files structure 12744 (0 used)
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file_unixpath(3226)
>  create_file_unixpath: NT_STATUS_OBJECT_NAME_NOT_FOUND
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file(3489)
>  create_file: NT_STATUS_OBJECT_NAME_NOT_FOUND
>[2009/06/02 09:07:58,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/error.c(137) cmd=160 (SMBnttrans) NT_STATUS_OBJECT_NAME_NOT_FOUND
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0xa0
>  smb_rcls=52
>  smb_reh=0
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45376
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:58, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 122
>[2009/06/02 09:07:58,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x7a
>[2009/06/02 09:07:58,  3] smbd/process.c:process_smb(1554)
>  Transaction 2025 of length 126 (0 toread)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=122
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45440
>  smt_wct=15
>  smb_vwv[ 0]=   54 (0x36)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    2 (0x2)
>  smb_vwv[ 3]=   40 (0x28)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=   54 (0x36)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=    5 (0x5)
>  smb_bcc=57
>[2009/06/02 09:07:58, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 EC 03 00 00 00  00 5C 00 6D 00 69 00 73  ...ì.... .\.m.i.s
>  [010] 00 63 00 5C 00 74 00 6D  00 70 00 5C 00 43 00 30  .c.\.t.m .p.\.C.0
>  [020] 00 30 00 30 00 30 00 30  00 30 00 64 00 64 00 46  .0.0.0.0 .0.d.d.F
>  [030] 00 49 00 4C 00 45 00 00  00                       .I.L.E.. .
>[2009/06/02 09:07:58,  3] smbd/process.c:switch_message(1378)
>  switch message SMBtrans2 (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:58,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:58,  3] smbd/trans2.c:call_trans2qfilepathinfo(3943)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 1004
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "misc/tmp/C000000ddFILE"
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(235)
>  stat_cache_lookup: lookup failed for name [MISC/TMP/C000000DDFILE]
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [MISC/TMP] -> [misc/tmp]
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(306)
>  unix_convert begin: name = misc/tmp/C000000ddFILE, dirpath = misc/tmp, start = C000000ddFILE
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(562)
>  New file C000000ddFILE
>[2009/06/02 09:07:58,  3] smbd/trans2.c:call_trans2qfilepathinfo(4037)
>  call_trans2qfilepathinfo: SMB_VFS_STAT of misc/tmp/C000000ddFILE failed (No such file or directory)
>[2009/06/02 09:07:58,  3] smbd/error.c:reply_unix_error(154)
>  unix_error_packet: error string = No such file or directory
>[2009/06/02 09:07:58,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/trans2.c(4038) cmd=50 (SMBtrans2) NT_STATUS_OBJECT_NAME_NOT_FOUND
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0x32
>  smb_rcls=52
>  smb_reh=0
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45440
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:07:58, 10] lib/util_sock.c:read_smb_length_return_keepalive(1187)
>  got smb length of 376
>[2009/06/02 09:07:58,  6] smbd/process.c:process_smb(1551)
>  got message type 0x0 of len 0x178
>[2009/06/02 09:07:58,  3] smbd/process.c:process_smb(1554)
>  Transaction 2026 of length 380 (0 toread)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=376
>  smb_com=0xa0
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45504
>  smt_wct=19
>  smb_vwv[ 0]=    0 (0x0)
>  smb_vwv[ 1]=25600 (0x6400)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=51200 (0xC800)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=25856 (0x6500)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=25600 (0x6400)
>  smb_vwv[10]=    0 (0x0)
>  smb_vwv[11]=19456 (0x4C00)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=51200 (0xC800)
>  smb_vwv[14]=    0 (0x0)
>  smb_vwv[15]=45056 (0xB000)
>  smb_vwv[16]=    0 (0x0)
>  smb_vwv[17]=    0 (0x0)
>  smb_vwv[18]=    1 (0x1)
>  smb_bcc=303
>[2009/06/02 09:07:58, 10] lib/util.c:dump_data(2233)
>  [000] 00 00 00 10 00 00 00 00  00 00 00 96 01 12 00 00  ........ ........
>  [010] 00 00 00 00 00 00 00 00  00 00 00 07 00 00 00 05  ........ ........
>  [020] 00 00 00 40 00 00 00 C8  00 00 00 00 00 00 00 2E  ...@...È ........
>  [030] 00 00 00 02 00 00 00 03  00 5C 00 6D 00 69 00 73  ........ .\.m.i.s
>  [040] 00 63 00 5C 00 74 00 6D  00 70 00 5C 00 43 00 30  .c.\.t.m .p.\.C.0
>  [050] 00 30 00 30 00 30 00 30  00 30 00 64 00 64 00 46  .0.0.0.0 .0.d.d.F
>  [060] 00 49 00 4C 00 45 00 01  00 04 80 90 00 00 00 AC  .I.L.E.. .......¬
>  [070] 00 00 00 00 00 00 00 14  00 00 00 02 00 7C 00 04  ........ .....|..
>  [080] 00 00 00 00 00 24 00 DF  01 1F 00 01 05 00 00 00  .....$.ß ........
>  [090] 00 00 05 15 00 00 00 EE  94 02 07 FF 13 98 15 43  .......î ...ÿ...C
>  [0A0] 17 0A 32 F4 01 00 00 00  00 24 00 DF 01 1F 00 01  ..2ô.... .$.ß....
>  [0B0] 05 00 00 00 00 00 05 15  00 00 00 EE 94 02 07 FF  ........ ...î...ÿ
>  [0C0] 13 98 15 43 17 0A 32 01  02 00 00 00 00 14 00 DF  ...C..2. .......ß
>  [0D0] 01 1F 00 01 01 00 00 00  00 00 01 00 00 00 00 00  ........ ........
>  [0E0] 00 18 00 FF 01 1F 00 01  02 00 00 00 00 00 05 20  ...ÿ.... ....... 
>  [0F0] 00 00 00 20 02 00 00 01  05 00 00 00 00 00 05 15  ... .... ........
>  [100] 00 00 00 EE 94 02 07 FF  13 98 15 43 17 0A 32 F4  ...î...ÿ ...C..2ô
>  [110] 01 00 00 01 05 00 00 00  00 00 05 15 00 00 00 EE  ........ .......î
>  [120] 94 02 07 FF 13 98 15 43  17 0A 32 01 02 00 00     ...ÿ...C ..2....
>[2009/06/02 09:07:58,  3] smbd/process.c:switch_message(1378)
>  switch message SMBnttrans (pid 6218) conn 0x552b251c40
>[2009/06/02 09:07:58,  4] smbd/uid.c:change_to_user(211)
>  change_to_user: Skipping user change - already user
>[2009/06/02 09:07:58,  5] smbd/nttrans.c:call_nt_transact_create(826)
>  call_nt_transact_create
>[2009/06/02 09:07:58, 10] smbd/nttrans.c:call_nt_transact_create(888)
>  call_nt_transact_create - sd_len = 200
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file(3283)
>  create_file: access_mask = 0x120196 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x5 create_options = 0x40 oplock_request = 0x0 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x0x552b24fdf0, fname = misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(151)
>  unix_convert called on file "misc/tmp/C000000ddFILE"
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(235)
>  stat_cache_lookup: lookup failed for name [MISC/TMP/C000000DDFILE]
>[2009/06/02 09:07:58, 10] smbd/statcache.c:stat_cache_lookup(274)
>  stat_cache_lookup: lookup succeeded for name [MISC/TMP] -> [misc/tmp]
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(306)
>  unix_convert begin: name = misc/tmp/C000000ddFILE, dirpath = misc/tmp, start = C000000ddFILE
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled(249)
>  is_mangled C000000ddFILE ?
>[2009/06/02 09:07:58, 10] smbd/mangle_hash2.c:is_mangled_component(188)
>  is_mangled_component C000000ddFILE (len 13) ?
>[2009/06/02 09:07:58,  5] smbd/filename.c:unix_convert(562)
>  New file C000000ddFILE
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file_unixpath(2889)
>  create_file_unixpath: access_mask = 0x120196 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x5 create_options = 0x40 oplock_request = 0x0 ea_list = 0x(nil), sd = 0x0x552b24fdf0, fname = misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  5] smbd/files.c:file_new(121)
>  allocated file structure 8649, fnum = 12745 (1 used)
>[2009/06/02 09:07:58,  3] smbd/dosmode.c:unix_mode(124)
>  unix_mode(misc/tmp/C000000ddFILE) returning 0764
>[2009/06/02 09:07:58, 10] smbd/open.c:open_file_ntcreate_internal(1447)
>  open_file_ntcreate: fname=misc/tmp/C000000ddFILE, dos_attrs=0x0 access_mask=0x120196 share_access=0x7 create_disposition = 0x5 create_options=0x40 unix mode=0764 oplock_request=0
>[2009/06/02 09:07:58, 10] smbd/open.c:open_file_ntcreate_internal(1625)
>  open_file_ntcreate: fname=misc/tmp/C000000ddFILE, after mapping access_mask=0x120196
>[2009/06/02 09:07:58,  4] smbd/open.c:open_file_ntcreate_internal(1884)
>  calling open_file with flags=0x2 flags2=0x240 mode=0764, access_mask = 0x120196, open_access_mask = 0x120196
>[2009/06/02 09:07:58, 10] smbd/open.c:fd_open(131)
>  fd_open: name misc/tmp/C000000ddFILE, flags = 0102 mode = 0764, fd = 24. 
>[2009/06/02 09:07:58, 10] smbd/notify_internal.c:notify_trigger(593)
>  notify_trigger called action=0x1, filter=0x1, path=/datafiles/misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  2] smbd/open.c:open_file(551)
>  enmac opened file misc/tmp/C000000ddFILE read=No write=Yes (numopen=1)
>[2009/06/02 09:07:58, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000006207
>[2009/06/02 09:07:58, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b250a30
>[2009/06/02 09:07:58, 10] smbd/open.c:delay_for_oplocks(952)
>  delay_for_oplocks: oplock type 0x10 on file misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58, 10] smbd/open.c:delay_for_oplocks(952)
>  delay_for_oplocks: oplock type 0x10 on file misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  5] smbd/oplock.c:set_file_oplock(126)
>  set_file_oplock: granted oplock on file misc/tmp/C000000ddFILE, fd00:400762/509, tv_sec = 4a247b6e, tv_usec = 32efe
>[2009/06/02 09:07:58, 10] smbd/dosmode.c:file_set_dosmode(436)
>  file_set_dosmode: setting dos mode 0x20 on file misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  8] smbd/dosmode.c:dos_mode(361)
>  dos_mode: misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  8] smbd/dosmode.c:dos_mode_from_sbuf(170)
>  dos_mode_from_sbuf returning a
>[2009/06/02 09:07:58,  8] smbd/dosmode.c:dos_mode(403)
>  dos_mode returning a
>[2009/06/02 09:07:58, 10] locking/locking.c:unparse_share_modes(683)
>  unparse_share_modes: del: 0, owrt: Tue 02 Jun 2009 09:07:58 WST WST cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num: 1
>[2009/06/02 09:07:58, 10] locking/locking.c:print_share_mode_table(485)
>  print_share_mode_table: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120196, mid = 0x0, type= 0x10, gen_id = 509, uid = 500, flags = 0, file_id fd00:400762
>[2009/06/02 09:07:58, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000006207
>[2009/06/02 09:07:58, 10] smbd/posix_acls.c:set_nt_acl(3488)
>  set_nt_acl: called for file misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  5] smbd/posix_acls.c:unpack_nt_owners(1010)
>  unpack_nt_owners: validating owner_sids.
>[2009/06/02 09:07:58, 10] lib/gencache.c:gencache_get(194)
>  Cache entry with key = IDMAP/SID2UID/S-1-5-21-117609710-362288127-839522115-500 couldn't be found
>[2009/06/02 09:07:58, 10] passdb/lookup_sid.c:legacy_sid_to_uid(1208)
>  LEGACY: mapping failed for sid S-1-5-21-117609710-362288127-839522115-500
>[2009/06/02 09:07:58,  3] smbd/posix_acls.c:unpack_nt_owners(1027)
>  unpack_nt_owners: unable to validate owner sid for S-1-5-21-117609710-362288127-839522115-500
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file_unixpath(3226)
>  create_file_unixpath: NT_STATUS_INVALID_OWNER
>[2009/06/02 09:07:58, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
>  Locking key 00FD0000000000006207
>[2009/06/02 09:07:58, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
>  Allocated locked data 0x0x552b251260
>[2009/06/02 09:07:58, 10] locking/locking.c:parse_share_modes(519)
>  parse_share_modes: delete_on_close: 0, owrt: Tue 02 Jun 2009 09:07:58 WST WST, cwrt: Thu 01 Jan 1970 08:00:00 WST WST, tok: 0, num_share_modes: 1
>[2009/06/02 09:07:58, 10] locking/locking.c:parse_share_modes(616)
>  parse_share_modes: share_mode_entry[0]:  pid = 6218, share_access = 0x7, private_options = 0x40, access_mask = 0x120196, mid = 0x0, type= 0x10, gen_id = 509, uid = 500, flags = 0, file_id fd00:400762
>[2009/06/02 09:07:58, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
>  Unlocking key 00FD0000000000006207
>[2009/06/02 09:07:58, 10] locking/posix.c:get_windows_lock_ref_count(495)
>  get_windows_lock_count for file misc/tmp/C000000ddFILE = 0
>[2009/06/02 09:07:58, 10] locking/posix.c:delete_windows_lock_ref_count(521)
>  delete_windows_lock_ref_count for file misc/tmp/C000000ddFILE
>[2009/06/02 09:07:58,  2] smbd/close.c:close_normal_file(606)
>  enmac closed file misc/tmp/C000000ddFILE (numopen=0) NT_STATUS_OK
>[2009/06/02 09:07:58,  5] smbd/files.c:file_free(471)
>  freed files structure 12745 (0 used)
>[2009/06/02 09:07:58, 10] smbd/open.c:create_file(3489)
>  create_file: NT_STATUS_INVALID_OWNER
>[2009/06/02 09:07:58,  3] smbd/error.c:error_packet_set(61)
>  error packet at smbd/error.c(137) cmd=160 (SMBnttrans) NT_STATUS_INVALID_OWNER
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(645)
>[2009/06/02 09:07:58,  5] lib/util.c:show_msg(655)
>  size=35
>  smb_com=0xa0
>  smb_rcls=90
>  smb_reh=0
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=49153
>  smb_tid=1
>  smb_pid=516
>  smb_uid=0
>  smb_mid=45504
>  smt_wct=0
>  smb_bcc=0
>[2009/06/02 09:08:03, 10] lib/events.c:run_events(231)
>  Running event "smbd_idle_event_handler" 552b254f30
>[2009/06/02 09:08:03, 10] lib/events.c:timed_event_destructor(55)
>  Destroying timed event 552b254f30 "smbd_idle_event_handler"
>[2009/06/02 09:08:03, 10] smbd/process.c:smbd_idle_event_handler(592)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) called
>[2009/06/02 09:08:03, 10] smbd/process.c:smbd_idle_event_handler(603)
>  smbd_idle_event_handler: idle_evt(deadtime) (nil) rescheduled
>[2009/06/02 09:08:03, 10] lib/events.c:_event_add_timed(120)
>  Added timed event "smbd_idle_event_handler": 552b24a6b0
>[2009/06/02 09:08:03, 10] lib/events.c:run_events(231)
>  Running event "smbd_idle_event_handler" 552b255900
>[2009/06/02 09:08:03, 10] lib/events.c:timed_event_destructor(55)
>  Destroying timed event 552b255900 "smbd_idle_event_handler"
>[2009/06/02 09:08:03, 10] smbd/process.c:smbd_idle_event_handler(592)
>  smbd_idle_event_handler: idle_evt(housekeeping) (nil) called
>[2009/06/02 09:08:03,  3] smbd/sec_ctx.c:set_sec_ctx(324)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/06/02 09:08:03,  5] auth/token_util.c:debug_nt_user_token(522)
>  NT user token: (NULL)
>[2009/06/02 09:08:03,  5] auth/token_util.c:debug_unix_user_token(548)
>  UNIX token of user 0
>  Primary group is 0 and contains 0 supplementary groups

Actions: View

Attachments on bug 6430: 4233 | 4234 | 4235 | 4236