Bug with Samba and IIS/ASP

David Collier-Brown davecb at canada.sun.com
Fri Jun 22 14:47:14 GMT 2001


Rod Potter wrote:
> I've included samples from Samba logs of sucessful and failed requests. I
> can provide detailed packet captures if you think it will help. Please let
> me know if I can provide more information.

Looking at these with Sun's old filemerge tool, the first difference
is

[2001/05/15 13:40:09, 5] smbd/uid.c:become_user(203)
  become_user uid=(0,1367) gid=(0,1367)
----
[2001/05/15 13:40:09, 3] smbd/vfs.c:vfs_ChDir(638)
  vfs_ChDir to
/rmounts/saratoga.ccs.yorku.ca/yorkweb/webs/rodp/MyWebSite
[2001/05/15 13:40:09, 1] smbd/service.c:make_connection(638)
----
  aspserver (130.63.236.61) connect to service RODPWWW as user RODPWWW
(uid=1367, gid=1367) (pid 19126)
[2001/05/15 13:40:09, 3] smbd/sec_ctx.c:set_sec_ctx(310)

	There is a vfs_ChDir in SambaGood.txt

	Then, still at 13:40:09, we see a very long sequence of 
	show_message's, SMBtrans2, becoem usre and so forth:

[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(563)
  write_socket(11,85) wrote 85
[2001/05/15 13:40:09, 10]
lib/util_sock.c:read_smb_length_return_keepalive(602)
----
  got smb length of 86
[2001/05/15 13:40:09, 6] smbd/process.c:process_smb(830)
  got message type 0x0 of len 0x56
[2001/05/15 13:40:09, 3] smbd/process.c:process_smb(831)
  Transaction 1218 of length 90
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(292)
  size=86
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=2055
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(298)
  smb_tid=2
  smb_pid=444
  smb_uid=248
  smb_mid=54990
  smt_wct=15
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[0]=18 (0x12)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[1]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[2]=2 (0x2)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[3]=40 (0x28)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[4]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[5]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[6]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[7]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[8]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[9]=18 (0x12)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[10]=68 (0x44)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[11]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[12]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[13]=1 (0x1)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[14]=5 (0x5)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(308)
  smb_bcc=21
[2001/05/15 13:40:09, 10] lib/util.c:dump_data(1517)
  [000] 02 00 00 01 01 00 00 00  00 5C 47 4C 4F 42 41 4C  ........
.\GLOBAL
[2001/05/15 13:40:09, 10] lib/util.c:dump_data(1525)
  [010] 2E 41 53 41 00                                    .ASA.
[2001/05/15 13:40:09, 3] smbd/process.c:switch_message(650)
  switch message SMBtrans2 (pid 19126)
[2001/05/15 13:40:09, 3] smbd/sec_ctx.c:set_sec_ctx(310)
  setting sec ctx (1367, 1367) - sec_ctx_stack_ndx = 0
[2001/05/15 13:40:09, 3] smbd/sec_ctx.c:set_sec_ctx(315)
  1 user groups:
  1367
[2001/05/15 13:40:09, 5] smbd/uid.c:become_user(203)
  become_user uid=(0,1367) gid=(0,1367)
[2001/05/15 13:40:09, 3] smbd/trans2.c:call_trans2qfilepathinfo(1355)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 257
[2001/05/15 13:40:09, 5] smbd/filename.c:unix_convert(146)
  unix_convert called on file "\GLOBAL.ASA"
[2001/05/15 13:40:09, 3] lib/util.c:unix_clean_name(384)
  unix_clean_name [/GLOBAL.ASA]
[2001/05/15 13:40:09, 5] smbd/mangle.c:is_8_3(338)
  Checking GLOBAL.ASA for 8.3
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1188)
  is_in_path: global.asa
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1193)
  is_in_path: no name list.
[2001/05/15 13:40:09, 3] lib/util.c:unix_clean_name(384)
  unix_clean_name [global.asa]
[2001/05/15 13:40:09, 3] smbd/trans2.c:call_trans2qfilepathinfo(1377)
  call_trans2qfilepathinfo global.asa level=257 call=5 total_data=0
[2001/05/15 13:40:09, 8] smbd/dosmode.c:dos_mode(125)
  dos_mode: global.asa
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1188)
  is_in_path: global.asa
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1193)
  is_in_path: no name list.
[2001/05/15 13:40:09, 8] smbd/dosmode.c:dos_mode(169)
  dos_mode returning
[2001/05/15 13:40:09, 5] smbd/trans2.c:call_trans2qfilepathinfo(1453)
  SMB_QFBI - create: Tue May 30 23:31:12 2000
   access: Tue May 15 12:58:06 2001
   write: Tue May 30 23:31:12 2000
   change: Tue May 30 23:31:12 2000
   mode: 0
[2001/05/15 13:40:09, 9] smbd/trans2.c:send_trans2_replies(158)
  t2_rep: params_sent_thistime = 2, data_sent_thistime = 36,
useable_space = 65471
[2001/05/15 13:40:09, 9] smbd/trans2.c:send_trans2_replies(160)
  t2_rep: params_to_send = 2, data_to_send = 36, paramsize = 2,
datasize = 36
[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(560)
  write_socket(11,102)
[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(563)
  write_socket(11,102) wrote 102
[2001/05/15 13:40:09, 10]
lib/util_sock.c:read_smb_length_return_keepalive(602)
  got smb length of 86
[2001/05/15 13:40:09, 6] smbd/process.c:process_smb(830)
  got message type 0x0 of len 0x56
[2001/05/15 13:40:09, 3] smbd/process.c:process_smb(831)
  Transaction 1219 of length 90
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(292)
  size=86
  smb_com=0x32
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=2055
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(298)
  smb_tid=2
  smb_pid=444
  smb_uid=248
  smb_mid=55044
  smt_wct=15
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[0]=18 (0x12)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[1]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[2]=2 (0x2)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[3]=24 (0x18)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[4]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[5]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[6]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[7]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[8]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[9]=18 (0x12)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[10]=68 (0x44)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[11]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[12]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[13]=1 (0x1)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[14]=5 (0x5)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(308)
  smb_bcc=21
[2001/05/15 13:40:09, 10] lib/util.c:dump_data(1517)
  [000] 02 00 00 02 01 00 00 00  00 5C 47 4C 4F 42 41 4C  ........
.\GLOBAL
[2001/05/15 13:40:09, 10] lib/util.c:dump_data(1525)
  [010] 2E 41 53 41 00                                    .ASA.
[2001/05/15 13:40:09, 3] smbd/process.c:switch_message(650)
  switch message SMBtrans2 (pid 19126)
[2001/05/15 13:40:09, 4] smbd/uid.c:become_user(119)
  Skipping become_user - already user
[2001/05/15 13:40:09, 3] smbd/trans2.c:call_trans2qfilepathinfo(1355)
  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 258
[2001/05/15 13:40:09, 5] smbd/filename.c:unix_convert(146)
  unix_convert called on file "\GLOBAL.ASA"
[2001/05/15 13:40:09, 3] lib/util.c:unix_clean_name(384)
  unix_clean_name [/GLOBAL.ASA]
[2001/05/15 13:40:09, 5] smbd/mangle.c:is_8_3(338)
  Checking GLOBAL.ASA for 8.3
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1188)
  is_in_path: global.asa
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1193)
  is_in_path: no name list.
[2001/05/15 13:40:09, 3] lib/util.c:unix_clean_name(384)
  unix_clean_name [global.asa]
[2001/05/15 13:40:09, 3] smbd/trans2.c:call_trans2qfilepathinfo(1377)
  call_trans2qfilepathinfo global.asa level=258 call=5 total_data=0
[2001/05/15 13:40:09, 8] smbd/dosmode.c:dos_mode(125)
  dos_mode: global.asa
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1188)
  is_in_path: global.asa
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1193)
  is_in_path: no name list.
[2001/05/15 13:40:09, 8] smbd/dosmode.c:dos_mode(169)
  dos_mode returning
[2001/05/15 13:40:09, 9] smbd/trans2.c:send_trans2_replies(158)
  t2_rep: params_sent_thistime = 2, data_sent_thistime = 22,
useable_space = 65471
[2001/05/15 13:40:09, 9] smbd/trans2.c:send_trans2_replies(160)
  t2_rep: params_to_send = 2, data_to_send = 22, paramsize = 2,
datasize = 22
[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(560)
  write_socket(11,88)
[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(563)
  write_socket(11,88) wrote 88
[2001/05/15 13:40:09, 10]
lib/util_sock.c:read_smb_length_return_keepalive(602)
  got smb length of 85
[2001/05/15 13:40:09, 6] smbd/process.c:process_smb(830)
  got message type 0x0 of len 0x55
[2001/05/15 13:40:09, 3] smbd/process.c:process_smb(831)
  Transaction 1220 of length 89
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(292)
  size=85
  smb_com=0xa2
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=2055
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(298)
  smb_tid=2
  smb_pid=444
  smb_uid=248
  smb_mid=55108
  smt_wct=24
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[0]=255 (0xFF)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[1]=57054 (0xDEDE)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[2]=512 (0x200)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[3]=5632 (0x1600)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[4]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[5]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[6]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[7]=33024 (0x8100)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[8]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[9]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[10]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[11]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[12]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[13]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[14]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[15]=1792 (0x700)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[16]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[17]=256 (0x100)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[18]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[19]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[20]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[21]=512 (0x200)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[22]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[23]=768 (0x300)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(308)
  smb_bcc=2
[2001/05/15 13:40:09, 10] lib/util.c:dump_data(1517)
  [000] 5C 00                                             \.
[2001/05/15 13:40:09, 3] smbd/process.c:switch_message(650)
  switch message SMBntcreateX (pid 19126)
[2001/05/15 13:40:09, 4] smbd/uid.c:become_user(119)
  Skipping become_user - already user
[2001/05/15 13:40:09, 10] smbd/nttrans.c:map_create_disposition(395)
  map_create_disposition: Mapped create_disposition 1 to 1
[2001/05/15 13:40:09, 10] smbd/nttrans.c:get_filename(262)
  get_filename: data_offset = 87, data_len = 2, fname_len = 2
[2001/05/15 13:40:09, 10] smbd/nttrans.c:map_share_mode(482)
  map_share_mode: FILE_SHARE_DELETE requested. open_mode = 8000
[2001/05/15 13:40:09, 10] smbd/nttrans.c:map_share_mode(522)
  map_share_mode: Mapped desired access 81, share access 7, file
attributes 0 to open_mode 8040
[2001/05/15 13:40:09, 5] smbd/filename.c:unix_convert(146)
  unix_convert called on file "\"
[2001/05/15 13:40:09, 3] lib/util.c:unix_clean_name(384)
  unix_clean_name [/]
[2001/05/15 13:40:09, 5] smbd/mangle.c:is_8_3(338)
  Checking . for 8.3
[2001/05/15 13:40:09, 5] smbd/filename.c:unix_convert(216)
  conversion finished . -> .
[2001/05/15 13:40:09, 3] smbd/dosmode.c:unix_mode(113)
  unix_mode(.) returning 0640
[2001/05/15 13:40:09, 5] smbd/files.c:file_new(107)
  allocated file structure 9761, fnum = 13857 (34 used)
[2001/05/15 13:40:09, 10] smbd/open.c:open_file_shared(611)
  open_file_shared: fname = ., share_mode = 8040, ofun = 1, mode =
640, oplock request = 3
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1188)
  is_in_path: .
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1193)
  is_in_path: no name list.
[2001/05/15 13:40:09, 3] lib/util.c:unix_clean_name(384)
  unix_clean_name [.]
[2001/05/15 13:40:09, 4] smbd/open.c:open_file_shared(740)
  calling open_file with flags=0x0 flags2=0x0 mode=0640
[2001/05/15 13:40:09, 10] smbd/open.c:fd_open(52)
  fd_open: name ., flags = 04000 mode = 0640, fd = 51.
[2001/05/15 13:40:09, 5] smbd/files.c:file_free(306)
  freed files structure 13857 (33 used)
[2001/05/15 13:40:09, 5] smbd/files.c:file_new(107)
  allocated file structure 9762, fnum = 13858 (34 used)
[2001/05/15 13:40:09, 5] smbd/open.c:open_directory(1072)
  open_directory: opening directory .
[2001/05/15 13:40:09, 8] smbd/dosmode.c:dos_mode(125)
  dos_mode: .
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1188)
  is_in_path: .
[2001/05/15 13:40:09, 8] lib/util.c:is_in_path(1193)
  is_in_path: no name list.
[2001/05/15 13:40:09, 8] smbd/dosmode.c:dos_mode(169)
  dos_mode returning d
[2001/05/15 13:40:09, 5] smbd/nttrans.c:reply_ntcreate_and_X(1013)
  reply_ntcreate_and_X: fnum = 13858, open name = .
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(292)
  size=103

  smb_com=0xa2
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=1
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(298)
  smb_tid=2
  smb_pid=444
  smb_uid=248
  smb_mid=55108
  smt_wct=34
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[0]=255 (0xFF)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[1]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[2]=8704 (0x2200)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[3]=310 (0x136)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[4]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[5]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[6]=22951 (0x59A7)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[7]=49296 (0xC090)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[8]=49372 (0xC0DC)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[9]=32769 (0x8001)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[10]=54684 (0xD59C)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[11]=24724 (0x6094)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[12]=49373 (0xC0DD)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[13]=1 (0x1)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[14]=22951 (0x59A7)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[15]=49296 (0xC090)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[16]=49372 (0xC0DC)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[17]=1 (0x1)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[18]=22951 (0x59A7)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[19]=49296 (0xC090)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[20]=49372 (0xC0DC)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[21]=4097 (0x1001)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[22]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[23]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[24]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[25]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[26]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[27]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[28]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[29]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[30]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[31]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[32]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[33]=256 (0x100)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(308)
  smb_bcc=0
[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(560)
  write_socket(11,107)
[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(563)
  write_socket(11,107) wrote 107
[2001/05/15 13:40:09, 10]
lib/util_sock.c:read_smb_length_return_keepalive(602)
  got smb length of 84
[2001/05/15 13:40:09, 6] smbd/process.c:process_smb(830)
  got message type 0x0 of len 0x54
[2001/05/15 13:40:09, 3] smbd/process.c:process_smb(831)
  Transaction 1221 of length 88
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(292)
  size=84
  smb_com=0xa0
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=2055
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(298)
  smb_tid=2
  smb_pid=444
  smb_uid=248
  smb_mid=55172
  smt_wct=23
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[0]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[1]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[2]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[3]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[4]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[5]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[6]=2 (0x2)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[7]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[8]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[9]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[10]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[11]=21504 (0x5400)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[12]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[13]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[14]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[15]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[16]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[17]=1024 (0x400)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[18]=4 (0x4)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[19]=287 (0x11F)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[20]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[21]=13858 (0x3622)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(303)
  smb_vwv[22]=0 (0x0)
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(308)
  smb_bcc=3
[2001/05/15 13:40:09, 10] lib/util.c:dump_data(1517)
  [000] 94 C8 5F                                          .._
[2001/05/15 13:40:09, 3] smbd/process.c:switch_message(650)
  switch message SMBnttrans (pid 19126)
[2001/05/15 13:40:09, 4] smbd/uid.c:become_user(119)
  Skipping become_user - already user
[2001/05/15 13:40:09, 10] smbd/nttrans.c:reply_nttrans(1867)
  reply_nttrans: setup_count = 8
[2001/05/15 13:40:09, 10] lib/util.c:dump_data(1517)
  [000] 1F 01 00 00 22 36 00 00                           ...."6..
[2001/05/15 13:40:09, 3]
smbd/nttrans.c:call_nt_transact_notify_change(1557)
  call_nt_transact_notify_change
[2001/05/15 13:40:09, 3]
smbd/notify_kernel.c:kernel_register_notify(160)
  kernel change notify on . (ntflags=0x11f flags=0x3e) fd=51
[2001/05/15 13:40:09, 3]
smbd/nttrans.c:call_nt_transact_notify_change(1570)
  call_nt_transact_notify_change: notify change called on directory
name = .
[2001/05/15 13:40:09, 10]
lib/util_sock.c:read_smb_length_return_keepalive(602)
  got smb length of 96
----- 
[2001/05/15 13:40:09, 6] smbd/process.c:process_smb(830)
  got message type 0x0 of len 0x60

then they syncg up again for a few lines, and split again, with
the good side doing
---
[2001/05/15 13:40:09, 4] smbd/uid.c:become_user(119)
  Skipping become_user - already user
[2001/05/15 13:40:09, 10] smbd/nttrans.c:map_create_disposition(395)
 ---

and the bad side doing
---
[2001/05/15 13:36:28, 3] smbd/sec_ctx.c:set_sec_ctx(310)
  setting sec ctx (1367, 1367) - sec_ctx_stack_ndx = 0
[2001/05/15 13:36:28, 3] smbd/sec_ctx.c:set_sec_ctx(315)
  1 user groups:
  1367
[2001/05/15 13:36:28, 5] smbd/uid.c:become_user(203)
  become_user uid=(0,1367) gid=(0,1367)
[2001/05/15 13:36:28, 10] smbd/nttrans.c:map_create_disposition(395)
----

a few more common, then good says
---
[2001/05/15 13:40:09, 2] smbd/open.c:open_file(216)
  RODPWWW opened file asptest.asp read=Yes write=No (numopen=2)

and bad says
---
[2001/05/15 13:36:28, 2] smbd/open.c:open_file(216)
  RODPWWW opened file asptest.asp read=Yes write=No (numopen=1)
---
Much later, after transferring the same html, the
two split again, with  the good side starting with 
---
[2001/05/15 13:40:09, 6] lib/util_sock.c:write_socket(563)
  write_socket(11,39) wrote 39
[2001/05/15 13:40:09, 10]
lib/util_sock.c:read_smb_length_return_keepalive(602)
  got smb length of 95
[2001/05/15 13:40:09, 6] smbd/process.c:process_smb(830)
  got message type 0x0 of len 0x5f
[2001/05/15 13:40:09, 3] smbd/process.c:process_smb(831)
  Transaction 1227 of length 99
[2001/05/15 13:40:09, 5] lib/util.c:show_msg(292)
  size=95
  smb_com=0xa2
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24

and the bad side just stopping there.  This
latter part may not be significant...

--daev




More information about the samba-technical mailing list