[2012/05/25 11:40:02,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:02,  3] smbd/oplock.c:init_oplocks(915)
  init_oplocks: initializing messages.
[2012/05/25 11:40:02, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc210
[2012/05/25 11:40:02, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(keepalive) 0xacc210
[2012/05/25 11:40:02, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc330
[2012/05/25 11:40:02, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(deadtime) 0xacc330
[2012/05/25 11:40:02, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc450
[2012/05/25 11:40:02, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(housekeeping) 0xacc450
[2012/05/25 11:40:02, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 68
[2012/05/25 11:40:02,  6] smbd/process.c:process_smb(1573)
  got message type 0x81 of len 0x44
[2012/05/25 11:40:02,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 72 (0 toread)
[2012/05/25 11:40:02,  2] smbd/reply.c:reply_special(497)
  netbios connect: name1=ECSSERV         name2=7CLIENT        
[2012/05/25 11:40:02,  2] smbd/reply.c:reply_special(504)
  netbios connect: local=ecsserv remote=7client, name type = 0
[2012/05/25 11:40:02,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:02,  5] smbd/reply.c:reply_special(544)
  init msg_type=0x81 msg_flags=0x0
[2012/05/25 11:40:02, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 133
[2012/05/25 11:40:02,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x85
[2012/05/25 11:40:02,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 137 (0 toread)
[2012/05/25 11:40:02,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:02,  5] lib/util.c:show_msg(655)
  size=133
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51283
  smb_tid=65535
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=0
  smb_bcc=98
[2012/05/25 11:40:02, 10] lib/util.c:dump_data(2268)
  [000] 02 50 43 20 4E 45 54 57  4F 52 4B 20 50 52 4F 47  .PC NETW ORK PROG
  [010] 52 41 4D 20 31 2E 30 00  02 4C 41 4E 4D 41 4E 31  RAM 1.0. .LANMAN1
  [020] 2E 30 00 02 57 69 6E 64  6F 77 73 20 66 6F 72 20  .0..Wind ows for 
  [030] 57 6F 72 6B 67 72 6F 75  70 73 20 33 2E 31 61 00  Workgrou ps 3.1a.
  [040] 02 4C 4D 31 2E 32 58 30  30 32 00 02 4C 41 4E 4D  .LM1.2X0 02..LANM
  [050] 41 4E 32 2E 31 00 02 4E  54 20 4C 4D 20 30 2E 31  AN2.1..N T LM 0.1
  [060] 32 00                                             2. 
[2012/05/25 11:40:02,  3] smbd/process.c:switch_message(1393)
  switch message SMBnegprot (pid 92) conn 0x0
[2012/05/25 11:40:02,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:02,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:02,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:02,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN1.0]
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [Windows for Workgroups 3.1a]
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LM1.2X002]
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN2.1]
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [NT LM 0.12]
[2012/05/25 11:40:02, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Win2K'
[2012/05/25 11:40:02,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:02,  5] smbd/connection.c:claim_connection(142)
  claiming []
[2012/05/25 11:40:02, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
  Locking key 5C000000FFFFFFFF0000
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 256, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 256, len 1 DONE
[2012/05/25 11:40:02, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
  Allocated locked data 0x0xaccb30
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 696 len=24 before writing.
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, failed (fd=9) at offset 696 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88396 len=4 before writing.
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, failed (fd=9) at offset 88396 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 89252 len=4 before writing.
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, failed (fd=9) at offset 89252 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88424 len=828 before writing.
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, failed (fd=9) at offset 88424 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 260 len=4 before writing.
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 260, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, failed (fd=9) at offset 260 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 260, len 4
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 260, len 4 DONE
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 260, len 4
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 260, len 4 DONE
[2012/05/25 11:40:02, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
  Unlocking key 5C000000FFFFFFFF0000
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 256, len 1
[2012/05/25 11:40:02,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5C, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 256, len 1 DONE
[2012/05/25 11:40:02,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_nt1(392)
  using SPNEGO
[2012/05/25 11:40:02,  3] smbd/negprot.c:reply_negprot(674)
  Selected protocol NT LM 0.12
[2012/05/25 11:40:02,  5] smbd/negprot.c:reply_negprot(681)
  negprot index=5
[2012/05/25 11:40:02,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:02,  5] lib/util.c:show_msg(655)
  size=127
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51283
  smb_tid=65535
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=17
  smb_vwv[ 0]=    5 (0x5)
  smb_vwv[ 1]=12803 (0x3203)
  smb_vwv[ 2]=  256 (0x100)
  smb_vwv[ 3]= 1024 (0x400)
  smb_vwv[ 4]=   65 (0x41)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=  256 (0x100)
  smb_vwv[ 7]=23552 (0x5C00)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=64768 (0xFD00)
  smb_vwv[10]=33011 (0x80F3)
  smb_vwv[11]=  128 (0x80)
  smb_vwv[12]= 1493 (0x5D5)
  smb_vwv[13]=27423 (0x6B1F)
  smb_vwv[14]=52538 (0xCD3A)
  smb_vwv[15]=    1 (0x1)
  smb_vwv[16]=    0 (0x0)
  smb_bcc=58
[2012/05/25 11:40:02, 10] lib/util.c:dump_data(2268)
  [000] 65 63 73 73 65 72 76 00  00 00 00 00 00 00 00 00  ecsserv. ........
  [010] 60 28 06 06 2B 06 01 05  05 02 A0 1E 30 1C A0 0E  `(..+... ....0...
  [020] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A3 0A  0...+... ..7.....
  [030] 30 08 A0 06 1B 04 4E 4F  4E 45                    0.....NO NE
[2012/05/25 11:40:05, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 138
[2012/05/25 11:40:05,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x8a
[2012/05/25 11:40:05,  3] smbd/process.c:process_smb(1576)
  Transaction 1 of length 142 (0 toread)
[2012/05/25 11:40:05,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:05,  5] lib/util.c:show_msg(655)
  size=138
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=0
  smb_mid=64
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=   74 (0x4A)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=79
[2012/05/25 11:40:05, 10] lib/util.c:dump_data(2268)
  [000] 60 48 06 06 2B 06 01 05  05 02 A0 3E 30 3C A0 0E  `H..+... ...>0<..
  [010] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A2 2A  0...+... ..7....*
  [020] 04 28 4E 54 4C 4D 53 53  50 00 01 00 00 00 97 82  .(NTLMSS P.......
  [030] 08 E2 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [040] 00 00 06 01 B1 1D 00 00  00 0F 00 00 00 00 00     ........ .......
[2012/05/25 11:40:05,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 92) conn 0x0
[2012/05/25 11:40:05,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:05,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:05,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:05,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:05,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:05,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:05,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:05,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:05, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Vista'
[2012/05/25 11:40:05, 10] smbd/password.c:register_initial_vuid(192)
  register_initial_vuid: allocated vuid = 100
[2012/05/25 11:40:05, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 74, pblob->length = 74
[2012/05/25 11:40:05,  5] smbd/sesssetup.c:parse_spnego_mechanisms(755)
  parse_spnego_mechanisms: Got OID 1 3 6 1 4 1 311 2 2 10
[2012/05/25 11:40:05,  3] smbd/sesssetup.c:reply_spnego_negotiate(806)
  reply_spnego_negotiate: Got secblob of size 40
[2012/05/25 11:40:05,  5] auth/auth.c:make_auth_context_subsystem(491)
  Making default auth method list for standalone security=user, encrypt passwords = yes
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam_ignoredomain
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam_ignoredomain'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend unix
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'unix'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend winbind
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'winbind'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend smbserver
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'smbserver'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend trustdomain
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'trustdomain'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend ntdomain
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'ntdomain'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend guest
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'guest'
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend script
[2012/05/25 11:40:05,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'script'
[2012/05/25 11:40:05,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match guest
[2012/05/25 11:40:05,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method guest has a valid init
[2012/05/25 11:40:05,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match sam
[2012/05/25 11:40:05,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method sam has a valid init
[2012/05/25 11:40:05,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
  Got NTLMSSP neg_flags=0xe2088297
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_NEGOTIATE_OEM
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_LM_KEY
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_NTLM2
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
    NTLMSSP_NEGOTIATE_56
[2012/05/25 11:40:05,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module guest did not want to specify a challenge
[2012/05/25 11:40:05,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module sam did not want to specify a challenge
[2012/05/25 11:40:05,  5] auth/auth.c:get_ntlm_challenge(136)
  auth_context challenge created by random
[2012/05/25 11:40:05,  5] auth/auth.c:get_ntlm_challenge(137)
  challenge is: 
[2012/05/25 11:40:05,  5] lib/util.c:dump_data(2268)
  [000] EB A1 D2 AE 52 EB 9B 79                           ....R..y 
[2012/05/25 11:40:05,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:05,  5] lib/util.c:show_msg(655)
  size=288
  smb_com=0x73
  smb_rcls=22
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51201
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=64
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  153 (0x99)
  smb_bcc=245
[2012/05/25 11:40:05, 10] lib/util.c:dump_data(2268)
  [000] A1 81 96 30 81 93 A0 03  0A 01 01 A1 0C 06 0A 2B  ...0.... .......+
  [010] 06 01 04 01 82 37 02 02  0A A2 7E 04 7C 4E 54 4C  .....7.. ..~.|NTL
  [020] 4D 53 53 50 00 02 00 00  00 0E 00 0E 00 30 00 00  MSSP.... .....0..
  [030] 00 15 82 8A E2 EB A1 D2  AE 52 EB 9B 79 00 00 00  ........ .R..y...
  [040] 00 00 00 00 00 3E 00 3E  00 3E 00 00 00 45 00 43  .....>.> .>...E.C
  [050] 00 53 00 53 00 45 00 52  00 56 00 02 00 0E 00 45  .S.S.E.R .V.....E
  [060] 00 43 00 53 00 53 00 45  00 52 00 56 00 01 00 0E  .C.S.S.E .R.V....
  [070] 00 45 00 43 00 53 00 53  00 45 00 52 00 56 00 04  .E.C.S.S .E.R.V..
  [080] 00 00 00 03 00 0E 00 65  00 43 00 53 00 53 00 65  .......e .C.S.S.e
  [090] 00 72 00 76 00 00 00 00  00 65 00 43 00 53 00 20  .r.v.... .e.C.S. 
  [0A0] 00 28 00 4F 00 53 00 2F  00 32 00 29 00 00 00 53  .(.O.S./ .2.)...S
  [0B0] 00 61 00 6D 00 62 00 61  00 20 00 33 00 2E 00 33  .a.m.b.a . .3...3
  [0C0] 00 2E 00 31 00 36 00 2D  00 65 00 43 00 53 00 20  ...1.6.- .e.C.S. 
  [0D0] 00 31 00 2E 00 31 00 2E  00 32 00 2D 00 36 00 38  .1...1.. .2.-.6.8
  [0E0] 00 37 00 00 00 58 00 58  00 58 00 58 00 58 00 58  .7...X.X .X.X.X.X
  [0F0] 00 58 00 00 00                                    .X... 
[2012/05/25 11:40:05, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 264
[2012/05/25 11:40:05,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x108
[2012/05/25 11:40:05,  3] smbd/process.c:process_smb(1576)
  Transaction 2 of length 268 (0 toread)
[2012/05/25 11:40:05,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:05,  5] lib/util.c:show_msg(655)
  size=264
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=128
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=  200 (0xC8)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=205
[2012/05/25 11:40:05, 10] lib/util.c:dump_data(2268)
  [000] A1 81 C5 30 81 C2 A2 81  BF 04 81 BC 4E 54 4C 4D  ...0.... ....NTLM
  [010] 53 53 50 00 03 00 00 00  18 00 18 00 7C 00 00 00  SSP..... ....|...
  [020] 18 00 18 00 94 00 00 00  0E 00 0E 00 58 00 00 00  ........ ....X...
  [030] 08 00 08 00 66 00 00 00  0E 00 0E 00 6E 00 00 00  ....f... ....n...
  [040] 10 00 10 00 AC 00 00 00  15 82 88 E2 06 01 B1 1D  ........ ........
  [050] 00 00 00 0F 8B 5D 58 2A  A1 39 2B BF F0 10 13 09  .....]X* .9+.....
  [060] 4D 81 C5 D5 65 00 43 00  53 00 53 00 65 00 72 00  M...e.C. S.S.e.r.
  [070] 76 00 72 00 6F 00 6F 00  74 00 37 00 43 00 4C 00  v.r.o.o. t.7.C.L.
  [080] 49 00 45 00 4E 00 54 00  54 2E 17 B7 2E FC 22 C5  I.E.N.T. T.....".
  [090] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [0A0] FB 63 67 14 0E 90 85 4F  B4 AC 5F A3 8F 34 4F F4  .cg....O .._..4O.
  [0B0] 05 4B B9 97 5A 31 E8 C6  3E 21 FC C0 38 3C EA C7  .K..Z1.. >!..8<..
  [0C0] 92 22 48 94 BC 94 D0 9C  00 00 00 00 00           ."H..... .....
[2012/05/25 11:40:05,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 92) conn 0x0
[2012/05/25 11:40:05,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:05,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:05,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:05,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:05,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:05,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:05,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:05,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:05, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 200, pblob->length = 200
[2012/05/25 11:40:05,  3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
  Got user=[root] domain=[eCSServ] workstation=[7CLIENT] len1=24 len2=24
[2012/05/25 11:40:05,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(68)
  auth_context challenge set by NTLMSSP callback (NTLM2)
[2012/05/25 11:40:05,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(69)
  challenge is: 
[2012/05/25 11:40:05,  5] lib/util.c:dump_data(2268)
  [000] 47 2A AE 7B 04 36 A7 BD                           G*.{.6.. 
[2012/05/25 11:40:06,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:06,  3] smbd/oplock.c:init_oplocks(915)
  init_oplocks: initializing messages.
[2012/05/25 11:40:06, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc210
[2012/05/25 11:40:06, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(keepalive) 0xacc210
[2012/05/25 11:40:06, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc330
[2012/05/25 11:40:06, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(deadtime) 0xacc330
[2012/05/25 11:40:06, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc450
[2012/05/25 11:40:06, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(housekeeping) 0xacc450
[2012/05/25 11:40:06, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 68
[2012/05/25 11:40:06,  6] smbd/process.c:process_smb(1573)
  got message type 0x81 of len 0x44
[2012/05/25 11:40:06,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 72 (0 toread)
[2012/05/25 11:40:06,  2] smbd/reply.c:reply_special(497)
  netbios connect: name1=ECSSERV         name2=7CLIENT        
[2012/05/25 11:40:06,  2] smbd/reply.c:reply_special(504)
  netbios connect: local=ecsserv remote=7client, name type = 0
[2012/05/25 11:40:06,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:06,  5] smbd/reply.c:reply_special(544)
  init msg_type=0x81 msg_flags=0x0
[2012/05/25 11:40:06, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 133
[2012/05/25 11:40:06,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x85
[2012/05/25 11:40:06,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 137 (0 toread)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(655)
  size=133
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51267
  smb_tid=0
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=0
  smb_bcc=98
[2012/05/25 11:40:06, 10] lib/util.c:dump_data(2268)
  [000] 02 50 43 20 4E 45 54 57  4F 52 4B 20 50 52 4F 47  .PC NETW ORK PROG
  [010] 52 41 4D 20 31 2E 30 00  02 4C 41 4E 4D 41 4E 31  RAM 1.0. .LANMAN1
  [020] 2E 30 00 02 57 69 6E 64  6F 77 73 20 66 6F 72 20  .0..Wind ows for 
  [030] 57 6F 72 6B 67 72 6F 75  70 73 20 33 2E 31 61 00  Workgrou ps 3.1a.
  [040] 02 4C 4D 31 2E 32 58 30  30 32 00 02 4C 41 4E 4D  .LM1.2X0 02..LANM
  [050] 41 4E 32 2E 31 00 02 4E  54 20 4C 4D 20 30 2E 31  AN2.1..N T LM 0.1
  [060] 32 00                                             2. 
[2012/05/25 11:40:06,  3] smbd/process.c:switch_message(1393)
  switch message SMBnegprot (pid 93) conn 0x0
[2012/05/25 11:40:06,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:06,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:06,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:06,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN1.0]
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [Windows for Workgroups 3.1a]
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LM1.2X002]
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN2.1]
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [NT LM 0.12]
[2012/05/25 11:40:06, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Win2K'
[2012/05/25 11:40:06,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:06,  5] smbd/connection.c:claim_connection(142)
  claiming []
[2012/05/25 11:40:06, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
  Locking key 5D000000FFFFFFFF0000
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 564, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 564, len 1 DONE
[2012/05/25 11:40:06, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
  Allocated locked data 0x0xaccb30
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 696 len=24 before writing.
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, failed (fd=9) at offset 696 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88396 len=4 before writing.
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, failed (fd=9) at offset 88396 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 89252 len=4 before writing.
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, failed (fd=9) at offset 89252 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88424 len=828 before writing.
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, failed (fd=9) at offset 88424 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 568 len=4 before writing.
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 568, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, failed (fd=9) at offset 568 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 568, len 4
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 568, len 4 DONE
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 568, len 4
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 568, len 4 DONE
[2012/05/25 11:40:06, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
  Unlocking key 5D000000FFFFFFFF0000
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 564, len 1
[2012/05/25 11:40:06,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5D, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 564, len 1 DONE
[2012/05/25 11:40:06,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:06, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Vista'
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_nt1(392)
  using SPNEGO
[2012/05/25 11:40:06,  3] smbd/negprot.c:reply_negprot(674)
  Selected protocol NT LM 0.12
[2012/05/25 11:40:06,  5] smbd/negprot.c:reply_negprot(681)
  negprot index=5
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(655)
  size=127
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51267
  smb_tid=0
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=17
  smb_vwv[ 0]=    5 (0x5)
  smb_vwv[ 1]=12803 (0x3203)
  smb_vwv[ 2]=  256 (0x100)
  smb_vwv[ 3]= 1024 (0x400)
  smb_vwv[ 4]=   65 (0x41)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=  256 (0x100)
  smb_vwv[ 7]=23808 (0x5D00)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=64768 (0xFD00)
  smb_vwv[10]=33011 (0x80F3)
  smb_vwv[11]=  128 (0x80)
  smb_vwv[12]=26671 (0x682F)
  smb_vwv[13]=27425 (0x6B21)
  smb_vwv[14]=52538 (0xCD3A)
  smb_vwv[15]=    1 (0x1)
  smb_vwv[16]=    0 (0x0)
  smb_bcc=58
[2012/05/25 11:40:06, 10] lib/util.c:dump_data(2268)
  [000] 65 63 73 73 65 72 76 00  00 00 00 00 00 00 00 00  ecsserv. ........
  [010] 60 28 06 06 2B 06 01 05  05 02 A0 1E 30 1C A0 0E  `(..+... ....0...
  [020] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A3 0A  0...+... ..7.....
  [030] 30 08 A0 06 1B 04 4E 4F  4E 45                    0.....NO NE
[2012/05/25 11:40:06, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 138
[2012/05/25 11:40:06,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x8a
[2012/05/25 11:40:06,  3] smbd/process.c:process_smb(1576)
  Transaction 1 of length 142 (0 toread)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(655)
  size=138
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=0
  smb_mid=256
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=   74 (0x4A)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=79
[2012/05/25 11:40:06, 10] lib/util.c:dump_data(2268)
  [000] 60 48 06 06 2B 06 01 05  05 02 A0 3E 30 3C A0 0E  `H..+... ...>0<..
  [010] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A2 2A  0...+... ..7....*
  [020] 04 28 4E 54 4C 4D 53 53  50 00 01 00 00 00 97 82  .(NTLMSS P.......
  [030] 08 E2 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [040] 00 00 06 01 B1 1D 00 00  00 0F 00 00 00 00 00     ........ .......
[2012/05/25 11:40:06,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 93) conn 0x0
[2012/05/25 11:40:06,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:06,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:06,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:06,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:06,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:06,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:06,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:06,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:06, 10] smbd/password.c:register_initial_vuid(192)
  register_initial_vuid: allocated vuid = 100
[2012/05/25 11:40:06, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 74, pblob->length = 74
[2012/05/25 11:40:06,  5] smbd/sesssetup.c:parse_spnego_mechanisms(755)
  parse_spnego_mechanisms: Got OID 1 3 6 1 4 1 311 2 2 10
[2012/05/25 11:40:06,  3] smbd/sesssetup.c:reply_spnego_negotiate(806)
  reply_spnego_negotiate: Got secblob of size 40
[2012/05/25 11:40:06,  5] auth/auth.c:make_auth_context_subsystem(491)
  Making default auth method list for standalone security=user, encrypt passwords = yes
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam_ignoredomain
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam_ignoredomain'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend unix
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'unix'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend winbind
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'winbind'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend smbserver
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'smbserver'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend trustdomain
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'trustdomain'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend ntdomain
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'ntdomain'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend guest
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'guest'
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend script
[2012/05/25 11:40:06,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'script'
[2012/05/25 11:40:06,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match guest
[2012/05/25 11:40:06,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method guest has a valid init
[2012/05/25 11:40:06,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match sam
[2012/05/25 11:40:06,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method sam has a valid init
[2012/05/25 11:40:06,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
  Got NTLMSSP neg_flags=0xe2088297
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_NEGOTIATE_OEM
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_LM_KEY
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_NTLM2
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
    NTLMSSP_NEGOTIATE_56
[2012/05/25 11:40:06,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module guest did not want to specify a challenge
[2012/05/25 11:40:06,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module sam did not want to specify a challenge
[2012/05/25 11:40:06,  5] auth/auth.c:get_ntlm_challenge(136)
  auth_context challenge created by random
[2012/05/25 11:40:06,  5] auth/auth.c:get_ntlm_challenge(137)
  challenge is: 
[2012/05/25 11:40:06,  5] lib/util.c:dump_data(2268)
  [000] EB A1 D2 AE 52 EB 9B 79                           ....R..y 
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(655)
  size=288
  smb_com=0x73
  smb_rcls=22
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51201
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=256
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  153 (0x99)
  smb_bcc=245
[2012/05/25 11:40:06, 10] lib/util.c:dump_data(2268)
  [000] A1 81 96 30 81 93 A0 03  0A 01 01 A1 0C 06 0A 2B  ...0.... .......+
  [010] 06 01 04 01 82 37 02 02  0A A2 7E 04 7C 4E 54 4C  .....7.. ..~.|NTL
  [020] 4D 53 53 50 00 02 00 00  00 0E 00 0E 00 30 00 00  MSSP.... .....0..
  [030] 00 15 82 8A E2 EB A1 D2  AE 52 EB 9B 79 00 00 00  ........ .R..y...
  [040] 00 00 00 00 00 3E 00 3E  00 3E 00 00 00 45 00 43  .....>.> .>...E.C
  [050] 00 53 00 53 00 45 00 52  00 56 00 02 00 0E 00 45  .S.S.E.R .V.....E
  [060] 00 43 00 53 00 53 00 45  00 52 00 56 00 01 00 0E  .C.S.S.E .R.V....
  [070] 00 45 00 43 00 53 00 53  00 45 00 52 00 56 00 04  .E.C.S.S .E.R.V..
  [080] 00 00 00 03 00 0E 00 65  00 43 00 53 00 53 00 65  .......e .C.S.S.e
  [090] 00 72 00 76 00 00 00 00  00 65 00 43 00 53 00 20  .r.v.... .e.C.S. 
  [0A0] 00 28 00 4F 00 53 00 2F  00 32 00 29 00 00 00 53  .(.O.S./ .2.)...S
  [0B0] 00 61 00 6D 00 62 00 61  00 20 00 33 00 2E 00 33  .a.m.b.a . .3...3
  [0C0] 00 2E 00 31 00 36 00 2D  00 65 00 43 00 53 00 20  ...1.6.- .e.C.S. 
  [0D0] 00 31 00 2E 00 31 00 2E  00 32 00 2D 00 36 00 38  .1...1.. .2.-.6.8
  [0E0] 00 37 00 00 00 58 00 58  00 58 00 58 00 58 00 58  .7...X.X .X.X.X.X
  [0F0] 00 58 00 00 00                                    .X... 
[2012/05/25 11:40:06, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 264
[2012/05/25 11:40:06,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x108
[2012/05/25 11:40:06,  3] smbd/process.c:process_smb(1576)
  Transaction 2 of length 268 (0 toread)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:06,  5] lib/util.c:show_msg(655)
  size=264
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=320
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=  200 (0xC8)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=205
[2012/05/25 11:40:06, 10] lib/util.c:dump_data(2268)
  [000] A1 81 C5 30 81 C2 A2 81  BF 04 81 BC 4E 54 4C 4D  ...0.... ....NTLM
  [010] 53 53 50 00 03 00 00 00  18 00 18 00 7C 00 00 00  SSP..... ....|...
  [020] 18 00 18 00 94 00 00 00  0E 00 0E 00 58 00 00 00  ........ ....X...
  [030] 08 00 08 00 66 00 00 00  0E 00 0E 00 6E 00 00 00  ....f... ....n...
  [040] 10 00 10 00 AC 00 00 00  15 82 88 E2 06 01 B1 1D  ........ ........
  [050] 00 00 00 0F F1 EC FE B8  25 DF 2E 59 7E F7 63 6D  ........ %..Y~.cm
  [060] 3D 31 31 05 65 00 43 00  53 00 53 00 65 00 72 00  =11.e.C. S.S.e.r.
  [070] 76 00 72 00 6F 00 6F 00  74 00 37 00 43 00 4C 00  v.r.o.o. t.7.C.L.
  [080] 49 00 45 00 4E 00 54 00  FB 5D 97 4F 5E 34 54 D6  I.E.N.T. .].O^4T.
  [090] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [0A0] 29 5C 85 2E 8A 1D 0E 89  0D 32 3B E0 EB 03 AA 3C  )\...... .2;....<
  [0B0] B9 39 EA 39 17 21 4F 3D  64 0C 69 04 0C AA A8 F0  .9.9.!O= d.i.....
  [0C0] A7 AB 7D B5 C8 9F 71 07  00 00 00 00 00           ..}...q. .....
[2012/05/25 11:40:06,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 93) conn 0x0
[2012/05/25 11:40:06,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:06,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:06,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:06,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:06,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:06,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:06,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:06,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:06, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 200, pblob->length = 200
[2012/05/25 11:40:06,  3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
  Got user=[root] domain=[eCSServ] workstation=[7CLIENT] len1=24 len2=24
[2012/05/25 11:40:06,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(68)
  auth_context challenge set by NTLMSSP callback (NTLM2)
[2012/05/25 11:40:06,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(69)
  challenge is: 
[2012/05/25 11:40:06,  5] lib/util.c:dump_data(2268)
  [000] 80 8A 4A 24 5B 21 39 FA                           ..J$[!9. 
[2012/05/25 11:40:07,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:07,  3] smbd/oplock.c:init_oplocks(915)
  init_oplocks: initializing messages.
[2012/05/25 11:40:07, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc270
[2012/05/25 11:40:07, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(keepalive) 0xacc270
[2012/05/25 11:40:07, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc390
[2012/05/25 11:40:07, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(deadtime) 0xacc390
[2012/05/25 11:40:07, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc4b0
[2012/05/25 11:40:07, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(housekeeping) 0xacc4b0
[2012/05/25 11:40:07, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 68
[2012/05/25 11:40:07,  6] smbd/process.c:process_smb(1573)
  got message type 0x81 of len 0x44
[2012/05/25 11:40:07,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 72 (0 toread)
[2012/05/25 11:40:07,  2] smbd/reply.c:reply_special(497)
  netbios connect: name1=ECSSERV         name2=7CLIENT        
[2012/05/25 11:40:07,  2] smbd/reply.c:reply_special(504)
  netbios connect: local=ecsserv remote=7client, name type = 0
[2012/05/25 11:40:07,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:07,  5] smbd/reply.c:reply_special(544)
  init msg_type=0x81 msg_flags=0x0
[2012/05/25 11:40:07, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 133
[2012/05/25 11:40:07,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x85
[2012/05/25 11:40:07,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 137 (0 toread)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(655)
  size=133
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51267
  smb_tid=0
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=0
  smb_bcc=98
[2012/05/25 11:40:07, 10] lib/util.c:dump_data(2268)
  [000] 02 50 43 20 4E 45 54 57  4F 52 4B 20 50 52 4F 47  .PC NETW ORK PROG
  [010] 52 41 4D 20 31 2E 30 00  02 4C 41 4E 4D 41 4E 31  RAM 1.0. .LANMAN1
  [020] 2E 30 00 02 57 69 6E 64  6F 77 73 20 66 6F 72 20  .0..Wind ows for 
  [030] 57 6F 72 6B 67 72 6F 75  70 73 20 33 2E 31 61 00  Workgrou ps 3.1a.
  [040] 02 4C 4D 31 2E 32 58 30  30 32 00 02 4C 41 4E 4D  .LM1.2X0 02..LANM
  [050] 41 4E 32 2E 31 00 02 4E  54 20 4C 4D 20 30 2E 31  AN2.1..N T LM 0.1
  [060] 32 00                                             2. 
[2012/05/25 11:40:07,  3] smbd/process.c:switch_message(1393)
  switch message SMBnegprot (pid 94) conn 0x0
[2012/05/25 11:40:07,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:07,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:07,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:07,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN1.0]
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [Windows for Workgroups 3.1a]
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LM1.2X002]
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN2.1]
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [NT LM 0.12]
[2012/05/25 11:40:07, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Win2K'
[2012/05/25 11:40:07,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:07,  5] smbd/connection.c:claim_connection(142)
  claiming []
[2012/05/25 11:40:07, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
  Locking key 5E000000FFFFFFFF0000
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 292, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 292, len 1 DONE
[2012/05/25 11:40:07, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
  Allocated locked data 0x0xaccb90
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 696 len=24 before writing.
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, failed (fd=9) at offset 696 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88396 len=4 before writing.
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, failed (fd=9) at offset 88396 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 89252 len=4 before writing.
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, failed (fd=9) at offset 89252 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88424 len=828 before writing.
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, failed (fd=9) at offset 88424 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 296 len=4 before writing.
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 296, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, failed (fd=9) at offset 296 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 296, len 4
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 296, len 4 DONE
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 296, len 4
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 296, len 4 DONE
[2012/05/25 11:40:07, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
  Unlocking key 5E000000FFFFFFFF0000
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 292, len 1
[2012/05/25 11:40:07,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5E, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 292, len 1 DONE
[2012/05/25 11:40:07,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:07, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Vista'
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_nt1(392)
  using SPNEGO
[2012/05/25 11:40:07,  3] smbd/negprot.c:reply_negprot(674)
  Selected protocol NT LM 0.12
[2012/05/25 11:40:07,  5] smbd/negprot.c:reply_negprot(681)
  negprot index=5
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(655)
  size=127
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51267
  smb_tid=0
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=17
  smb_vwv[ 0]=    5 (0x5)
  smb_vwv[ 1]=12803 (0x3203)
  smb_vwv[ 2]=  256 (0x100)
  smb_vwv[ 3]= 1024 (0x400)
  smb_vwv[ 4]=   65 (0x41)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=  256 (0x100)
  smb_vwv[ 7]=24064 (0x5E00)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=64768 (0xFD00)
  smb_vwv[10]=33011 (0x80F3)
  smb_vwv[11]=32896 (0x8080)
  smb_vwv[12]=  197 (0xC5)
  smb_vwv[13]=27426 (0x6B22)
  smb_vwv[14]=52538 (0xCD3A)
  smb_vwv[15]=    1 (0x1)
  smb_vwv[16]=    0 (0x0)
  smb_bcc=58
[2012/05/25 11:40:07, 10] lib/util.c:dump_data(2268)
  [000] 65 63 73 73 65 72 76 00  00 00 00 00 00 00 00 00  ecsserv. ........
  [010] 60 28 06 06 2B 06 01 05  05 02 A0 1E 30 1C A0 0E  `(..+... ....0...
  [020] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A3 0A  0...+... ..7.....
  [030] 30 08 A0 06 1B 04 4E 4F  4E 45                    0.....NO NE
[2012/05/25 11:40:07, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 138
[2012/05/25 11:40:07,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x8a
[2012/05/25 11:40:07,  3] smbd/process.c:process_smb(1576)
  Transaction 1 of length 142 (0 toread)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(655)
  size=138
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=0
  smb_mid=448
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=   74 (0x4A)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=79
[2012/05/25 11:40:07, 10] lib/util.c:dump_data(2268)
  [000] 60 48 06 06 2B 06 01 05  05 02 A0 3E 30 3C A0 0E  `H..+... ...>0<..
  [010] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A2 2A  0...+... ..7....*
  [020] 04 28 4E 54 4C 4D 53 53  50 00 01 00 00 00 97 82  .(NTLMSS P.......
  [030] 08 E2 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [040] 00 00 06 01 B1 1D 00 00  00 0F 00 00 00 00 00     ........ .......
[2012/05/25 11:40:07,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 94) conn 0x0
[2012/05/25 11:40:07,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:07,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:07,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:07,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:07,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:07,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:07,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:07,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:07, 10] smbd/password.c:register_initial_vuid(192)
  register_initial_vuid: allocated vuid = 100
[2012/05/25 11:40:07, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 74, pblob->length = 74
[2012/05/25 11:40:07,  5] smbd/sesssetup.c:parse_spnego_mechanisms(755)
  parse_spnego_mechanisms: Got OID 1 3 6 1 4 1 311 2 2 10
[2012/05/25 11:40:07,  3] smbd/sesssetup.c:reply_spnego_negotiate(806)
  reply_spnego_negotiate: Got secblob of size 40
[2012/05/25 11:40:07,  5] auth/auth.c:make_auth_context_subsystem(491)
  Making default auth method list for standalone security=user, encrypt passwords = yes
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam_ignoredomain
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam_ignoredomain'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend unix
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'unix'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend winbind
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'winbind'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend smbserver
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'smbserver'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend trustdomain
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'trustdomain'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend ntdomain
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'ntdomain'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend guest
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'guest'
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend script
[2012/05/25 11:40:07,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'script'
[2012/05/25 11:40:07,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match guest
[2012/05/25 11:40:07,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method guest has a valid init
[2012/05/25 11:40:07,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match sam
[2012/05/25 11:40:07,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method sam has a valid init
[2012/05/25 11:40:07,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
  Got NTLMSSP neg_flags=0xe2088297
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_NEGOTIATE_OEM
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_LM_KEY
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_NTLM2
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
    NTLMSSP_NEGOTIATE_56
[2012/05/25 11:40:07,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module guest did not want to specify a challenge
[2012/05/25 11:40:07,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module sam did not want to specify a challenge
[2012/05/25 11:40:07,  5] auth/auth.c:get_ntlm_challenge(136)
  auth_context challenge created by random
[2012/05/25 11:40:07,  5] auth/auth.c:get_ntlm_challenge(137)
  challenge is: 
[2012/05/25 11:40:07,  5] lib/util.c:dump_data(2268)
  [000] EB A1 D2 AE 52 EB 9B 79                           ....R..y 
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(655)
  size=288
  smb_com=0x73
  smb_rcls=22
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51201
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=448
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  153 (0x99)
  smb_bcc=245
[2012/05/25 11:40:07, 10] lib/util.c:dump_data(2268)
  [000] A1 81 96 30 81 93 A0 03  0A 01 01 A1 0C 06 0A 2B  ...0.... .......+
  [010] 06 01 04 01 82 37 02 02  0A A2 7E 04 7C 4E 54 4C  .....7.. ..~.|NTL
  [020] 4D 53 53 50 00 02 00 00  00 0E 00 0E 00 30 00 00  MSSP.... .....0..
  [030] 00 15 82 8A E2 EB A1 D2  AE 52 EB 9B 79 00 00 00  ........ .R..y...
  [040] 00 00 00 00 00 3E 00 3E  00 3E 00 00 00 45 00 43  .....>.> .>...E.C
  [050] 00 53 00 53 00 45 00 52  00 56 00 02 00 0E 00 45  .S.S.E.R .V.....E
  [060] 00 43 00 53 00 53 00 45  00 52 00 56 00 01 00 0E  .C.S.S.E .R.V....
  [070] 00 45 00 43 00 53 00 53  00 45 00 52 00 56 00 04  .E.C.S.S .E.R.V..
  [080] 00 00 00 03 00 0E 00 65  00 43 00 53 00 53 00 65  .......e .C.S.S.e
  [090] 00 72 00 76 00 00 00 00  00 65 00 43 00 53 00 20  .r.v.... .e.C.S. 
  [0A0] 00 28 00 4F 00 53 00 2F  00 32 00 29 00 00 00 53  .(.O.S./ .2.)...S
  [0B0] 00 61 00 6D 00 62 00 61  00 20 00 33 00 2E 00 33  .a.m.b.a . .3...3
  [0C0] 00 2E 00 31 00 36 00 2D  00 65 00 43 00 53 00 20  ...1.6.- .e.C.S. 
  [0D0] 00 31 00 2E 00 31 00 2E  00 32 00 2D 00 36 00 38  .1...1.. .2.-.6.8
  [0E0] 00 37 00 00 00 58 00 58  00 58 00 58 00 58 00 58  .7...X.X .X.X.X.X
  [0F0] 00 58 00 00 00                                    .X... 
[2012/05/25 11:40:07, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 264
[2012/05/25 11:40:07,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x108
[2012/05/25 11:40:07,  3] smbd/process.c:process_smb(1576)
  Transaction 2 of length 268 (0 toread)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:07,  5] lib/util.c:show_msg(655)
  size=264
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=512
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=  200 (0xC8)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=205
[2012/05/25 11:40:07, 10] lib/util.c:dump_data(2268)
  [000] A1 81 C5 30 81 C2 A2 81  BF 04 81 BC 4E 54 4C 4D  ...0.... ....NTLM
  [010] 53 53 50 00 03 00 00 00  18 00 18 00 7C 00 00 00  SSP..... ....|...
  [020] 18 00 18 00 94 00 00 00  0E 00 0E 00 58 00 00 00  ........ ....X...
  [030] 08 00 08 00 66 00 00 00  0E 00 0E 00 6E 00 00 00  ....f... ....n...
  [040] 10 00 10 00 AC 00 00 00  15 82 88 E2 06 01 B1 1D  ........ ........
  [050] 00 00 00 0F 91 60 31 9B  19 40 07 27 94 35 A2 7E  .....`1. .@.'.5.~
  [060] 98 B6 7A CB 65 00 43 00  53 00 53 00 65 00 72 00  ..z.e.C. S.S.e.r.
  [070] 76 00 72 00 6F 00 6F 00  74 00 37 00 43 00 4C 00  v.r.o.o. t.7.C.L.
  [080] 49 00 45 00 4E 00 54 00  F2 47 F9 49 84 FF 65 2E  I.E.N.T. .G.I..e.
  [090] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [0A0] 56 FE 32 24 EA 9C 71 23  04 8A 7D 62 CE 08 34 B9  V.2$..q# ..}b..4.
  [0B0] A8 60 7C F7 E2 3B DD 08  7B 3E 3D 3B 8A 70 73 3D  .`|..;.. {>=;.ps=
  [0C0] 7C 33 08 1D A5 ED 5C 89  00 00 00 00 00           |3....\. .....
[2012/05/25 11:40:07,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 94) conn 0x0
[2012/05/25 11:40:07,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:07,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:07,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:07,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:07,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:07,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:07,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:07,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:07, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 200, pblob->length = 200
[2012/05/25 11:40:07,  3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
  Got user=[root] domain=[eCSServ] workstation=[7CLIENT] len1=24 len2=24
[2012/05/25 11:40:07,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(68)
  auth_context challenge set by NTLMSSP callback (NTLM2)
[2012/05/25 11:40:07,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(69)
  challenge is: 
[2012/05/25 11:40:07,  5] lib/util.c:dump_data(2268)
  [000] D6 C4 CB F6 1E 97 E2 10                           ........ 
[2012/05/25 11:40:08,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:08,  3] smbd/oplock.c:init_oplocks(915)
  init_oplocks: initializing messages.
[2012/05/25 11:40:08, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc270
[2012/05/25 11:40:08, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(keepalive) 0xacc270
[2012/05/25 11:40:08, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc390
[2012/05/25 11:40:08, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(deadtime) 0xacc390
[2012/05/25 11:40:08, 10] lib/events.c:_event_add_timed(120)
  Added timed event "smbd_idle_event_handler": acc4b0
[2012/05/25 11:40:08, 10] smbd/process.c:event_add_idle(660)
  event_add_idle: idle_evt(housekeeping) 0xacc4b0
[2012/05/25 11:40:08, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 68
[2012/05/25 11:40:08,  6] smbd/process.c:process_smb(1573)
  got message type 0x81 of len 0x44
[2012/05/25 11:40:08,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 72 (0 toread)
[2012/05/25 11:40:08,  2] smbd/reply.c:reply_special(497)
  netbios connect: name1=ECSSERV         name2=7CLIENT        
[2012/05/25 11:40:08,  2] smbd/reply.c:reply_special(504)
  netbios connect: local=ecsserv remote=7client, name type = 0
[2012/05/25 11:40:08,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:08,  5] smbd/reply.c:reply_special(544)
  init msg_type=0x81 msg_flags=0x0
[2012/05/25 11:40:08, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 133
[2012/05/25 11:40:08,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x85
[2012/05/25 11:40:08,  3] smbd/process.c:process_smb(1576)
  Transaction 0 of length 137 (0 toread)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(655)
  size=133
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51267
  smb_tid=0
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=0
  smb_bcc=98
[2012/05/25 11:40:08, 10] lib/util.c:dump_data(2268)
  [000] 02 50 43 20 4E 45 54 57  4F 52 4B 20 50 52 4F 47  .PC NETW ORK PROG
  [010] 52 41 4D 20 31 2E 30 00  02 4C 41 4E 4D 41 4E 31  RAM 1.0. .LANMAN1
  [020] 2E 30 00 02 57 69 6E 64  6F 77 73 20 66 6F 72 20  .0..Wind ows for 
  [030] 57 6F 72 6B 67 72 6F 75  70 73 20 33 2E 31 61 00  Workgrou ps 3.1a.
  [040] 02 4C 4D 31 2E 32 58 30  30 32 00 02 4C 41 4E 4D  .LM1.2X0 02..LANM
  [050] 41 4E 32 2E 31 00 02 4E  54 20 4C 4D 20 30 2E 31  AN2.1..N T LM 0.1
  [060] 32 00                                             2. 
[2012/05/25 11:40:08,  3] smbd/process.c:switch_message(1393)
  switch message SMBnegprot (pid 95) conn 0x0
[2012/05/25 11:40:08,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:08,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:08,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:08,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN1.0]
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [Windows for Workgroups 3.1a]
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LM1.2X002]
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [LANMAN2.1]
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_negprot(569)
  Requested protocol [NT LM 0.12]
[2012/05/25 11:40:08, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Win2K'
[2012/05/25 11:40:08,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:08,  5] smbd/connection.c:claim_connection(142)
  claiming []
[2012/05/25 11:40:08, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(100)
  Locking key 5F000000FFFFFFFF0000
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 544, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 544, len 1 DONE
[2012/05/25 11:40:08, 10] lib/dbwrap_tdb.c:db_tdb_fetch_locked(129)
  Allocated locked data 0x0xaccb90
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_WRLCK, offset 164, len 1 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 696 len=24 before writing.
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, failed (fd=9) at offset 696 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 696, len 24 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 696, len 24 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88396 len=4 before writing.
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, failed (fd=9) at offset 88396 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88396, len 4 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 89252 len=4 before writing.
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, failed (fd=9) at offset 89252 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 89252, len 4 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 164, len 1 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88400 len=24 before writing.
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, failed (fd=9) at offset 88400 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88400, len 24 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 88424 len=828 before writing.
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, failed (fd=9) at offset 88424 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 88424, len 828 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): unlocking at 548 len=4 before writing.
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 548, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, failed (fd=9) at offset 548 rw_type=2 lck_type=8 len=1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 548, len 4
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_WRLCK, offset 548, len 4 DONE
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 548, len 4
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLK, rw_type F_UNLCK, offset 548, len 4 DONE
[2012/05/25 11:40:08, 10] lib/dbwrap_tdb.c:db_tdb_record_destr(42)
  Unlocking key 5F000000FFFFFFFF0000
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 544, len 1
[2012/05/25 11:40:08,  5] lib/util_tdb.c:tdb_wrap_log(886)
  tdb(C:\MPTN\ETC\samba\lock/connections.tdb): tdb_brlock pid 5F, fd 9, lck_type F_SETLKW, rw_type F_UNLCK, offset 544, len 1 DONE
[2012/05/25 11:40:08,  6] param/loadparm.c:lp_file_list_changed(6801)
  lp_file_list_changed()
  file C:\MPTN\ETC/samba/smb.conf -> C:\MPTN\ETC/samba/smb.conf  last mod_time: Wed May 23 15:52:10 2012
  
[2012/05/25 11:40:08, 10] lib/util.c:set_remote_arch(2243)
  set_remote_arch: Client arch is 'Vista'
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_nt1(392)
  using SPNEGO
[2012/05/25 11:40:08,  3] smbd/negprot.c:reply_negprot(674)
  Selected protocol NT LM 0.12
[2012/05/25 11:40:08,  5] smbd/negprot.c:reply_negprot(681)
  negprot index=5
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(655)
  size=127
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=136
  smb_flg2=51267
  smb_tid=0
  smb_pid=65279
  smb_uid=0
  smb_mid=0
  smt_wct=17
  smb_vwv[ 0]=    5 (0x5)
  smb_vwv[ 1]=12803 (0x3203)
  smb_vwv[ 2]=  256 (0x100)
  smb_vwv[ 3]= 1024 (0x400)
  smb_vwv[ 4]=   65 (0x41)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=  256 (0x100)
  smb_vwv[ 7]=24320 (0x5F00)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=64768 (0xFD00)
  smb_vwv[10]=33011 (0x80F3)
  smb_vwv[11]=  128 (0x80)
  smb_vwv[12]=39260 (0x995C)
  smb_vwv[13]=27426 (0x6B22)
  smb_vwv[14]=52538 (0xCD3A)
  smb_vwv[15]=    1 (0x1)
  smb_vwv[16]=    0 (0x0)
  smb_bcc=58
[2012/05/25 11:40:08, 10] lib/util.c:dump_data(2268)
  [000] 65 63 73 73 65 72 76 00  00 00 00 00 00 00 00 00  ecsserv. ........
  [010] 60 28 06 06 2B 06 01 05  05 02 A0 1E 30 1C A0 0E  `(..+... ....0...
  [020] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A3 0A  0...+... ..7.....
  [030] 30 08 A0 06 1B 04 4E 4F  4E 45                    0.....NO NE
[2012/05/25 11:40:08, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 138
[2012/05/25 11:40:08,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x8a
[2012/05/25 11:40:08,  3] smbd/process.c:process_smb(1576)
  Transaction 1 of length 142 (0 toread)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(655)
  size=138
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=0
  smb_mid=640
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=   74 (0x4A)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=79
[2012/05/25 11:40:08, 10] lib/util.c:dump_data(2268)
  [000] 60 48 06 06 2B 06 01 05  05 02 A0 3E 30 3C A0 0E  `H..+... ...>0<..
  [010] 30 0C 06 0A 2B 06 01 04  01 82 37 02 02 0A A2 2A  0...+... ..7....*
  [020] 04 28 4E 54 4C 4D 53 53  50 00 01 00 00 00 97 82  .(NTLMSS P.......
  [030] 08 E2 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [040] 00 00 06 01 B1 1D 00 00  00 0F 00 00 00 00 00     ........ .......
[2012/05/25 11:40:08,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 95) conn 0x0
[2012/05/25 11:40:08,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:08,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:08,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:08,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:08,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:08,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:08,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:08,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:08, 10] smbd/password.c:register_initial_vuid(192)
  register_initial_vuid: allocated vuid = 100
[2012/05/25 11:40:08, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 74, pblob->length = 74
[2012/05/25 11:40:08,  5] smbd/sesssetup.c:parse_spnego_mechanisms(755)
  parse_spnego_mechanisms: Got OID 1 3 6 1 4 1 311 2 2 10
[2012/05/25 11:40:08,  3] smbd/sesssetup.c:reply_spnego_negotiate(806)
  reply_spnego_negotiate: Got secblob of size 40
[2012/05/25 11:40:08,  5] auth/auth.c:make_auth_context_subsystem(491)
  Making default auth method list for standalone security=user, encrypt passwords = yes
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend sam_ignoredomain
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'sam_ignoredomain'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend unix
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'unix'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend winbind
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'winbind'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend smbserver
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'smbserver'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend trustdomain
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'trustdomain'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend ntdomain
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'ntdomain'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend guest
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'guest'
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(46)
  Attempting to register auth backend script
[2012/05/25 11:40:08,  5] auth/auth.c:smb_register_auth(58)
  Successfully added auth method 'script'
[2012/05/25 11:40:08,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match guest
[2012/05/25 11:40:08,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method guest has a valid init
[2012/05/25 11:40:08,  5] auth/auth.c:load_auth_module(387)
  load_auth_module: Attempting to find an auth method to match sam
[2012/05/25 11:40:08,  5] auth/auth.c:load_auth_module(412)
  load_auth_module: auth method sam has a valid init
[2012/05/25 11:40:08,  3] libsmb/ntlmssp.c:debug_ntlmssp_flags(62)
  Got NTLMSSP neg_flags=0xe2088297
    NTLMSSP_NEGOTIATE_UNICODE
    NTLMSSP_NEGOTIATE_OEM
    NTLMSSP_REQUEST_TARGET
    NTLMSSP_NEGOTIATE_SIGN
    NTLMSSP_NEGOTIATE_LM_KEY
    NTLMSSP_NEGOTIATE_NTLM
    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
    NTLMSSP_NEGOTIATE_NTLM2
    NTLMSSP_NEGOTIATE_VERSION
    NTLMSSP_NEGOTIATE_128
    NTLMSSP_NEGOTIATE_KEY_EXCH
    NTLMSSP_NEGOTIATE_56
[2012/05/25 11:40:08,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module guest did not want to specify a challenge
[2012/05/25 11:40:08,  5] auth/auth.c:get_ntlm_challenge(96)
  auth_get_challenge: module sam did not want to specify a challenge
[2012/05/25 11:40:08,  5] auth/auth.c:get_ntlm_challenge(136)
  auth_context challenge created by random
[2012/05/25 11:40:08,  5] auth/auth.c:get_ntlm_challenge(137)
  challenge is: 
[2012/05/25 11:40:08,  5] lib/util.c:dump_data(2268)
  [000] EB A1 D2 AE 52 EB 9B 79                           ....R..y 
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(655)
  size=288
  smb_com=0x73
  smb_rcls=22
  smb_reh=0
  smb_err=49152
  smb_flg=136
  smb_flg2=51201
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=640
  smt_wct=4
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=    0 (0x0)
  smb_vwv[ 3]=  153 (0x99)
  smb_bcc=245
[2012/05/25 11:40:08, 10] lib/util.c:dump_data(2268)
  [000] A1 81 96 30 81 93 A0 03  0A 01 01 A1 0C 06 0A 2B  ...0.... .......+
  [010] 06 01 04 01 82 37 02 02  0A A2 7E 04 7C 4E 54 4C  .....7.. ..~.|NTL
  [020] 4D 53 53 50 00 02 00 00  00 0E 00 0E 00 30 00 00  MSSP.... .....0..
  [030] 00 15 82 8A E2 EB A1 D2  AE 52 EB 9B 79 00 00 00  ........ .R..y...
  [040] 00 00 00 00 00 3E 00 3E  00 3E 00 00 00 45 00 43  .....>.> .>...E.C
  [050] 00 53 00 53 00 45 00 52  00 56 00 02 00 0E 00 45  .S.S.E.R .V.....E
  [060] 00 43 00 53 00 53 00 45  00 52 00 56 00 01 00 0E  .C.S.S.E .R.V....
  [070] 00 45 00 43 00 53 00 53  00 45 00 52 00 56 00 04  .E.C.S.S .E.R.V..
  [080] 00 00 00 03 00 0E 00 65  00 43 00 53 00 53 00 65  .......e .C.S.S.e
  [090] 00 72 00 76 00 00 00 00  00 65 00 43 00 53 00 20  .r.v.... .e.C.S. 
  [0A0] 00 28 00 4F 00 53 00 2F  00 32 00 29 00 00 00 53  .(.O.S./ .2.)...S
  [0B0] 00 61 00 6D 00 62 00 61  00 20 00 33 00 2E 00 33  .a.m.b.a . .3...3
  [0C0] 00 2E 00 31 00 36 00 2D  00 65 00 43 00 53 00 20  ...1.6.- .e.C.S. 
  [0D0] 00 31 00 2E 00 31 00 2E  00 32 00 2D 00 36 00 38  .1...1.. .2.-.6.8
  [0E0] 00 37 00 00 00 58 00 58  00 58 00 58 00 58 00 58  .7...X.X .X.X.X.X
  [0F0] 00 58 00 00 00                                    .X... 
[2012/05/25 11:40:08, 10] lib/util_sock.c:read_smb_length_return_keepalive(1192)
  got smb length of 264
[2012/05/25 11:40:08,  6] smbd/process.c:process_smb(1573)
  got message type 0x0 of len 0x108
[2012/05/25 11:40:08,  3] smbd/process.c:process_smb(1576)
  Transaction 2 of length 268 (0 toread)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(645)
[2012/05/25 11:40:08,  5] lib/util.c:show_msg(655)
  size=264
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=24
  smb_flg2=51223
  smb_tid=65535
  smb_pid=65279
  smb_uid=100
  smb_mid=704
  smt_wct=12
  smb_vwv[ 0]=  255 (0xFF)
  smb_vwv[ 1]=    0 (0x0)
  smb_vwv[ 2]=16644 (0x4104)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]=    0 (0x0)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=  200 (0xC8)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=  212 (0xD4)
  smb_vwv[11]=40960 (0xA000)
  smb_bcc=205
[2012/05/25 11:40:08, 10] lib/util.c:dump_data(2268)
  [000] A1 81 C5 30 81 C2 A2 81  BF 04 81 BC 4E 54 4C 4D  ...0.... ....NTLM
  [010] 53 53 50 00 03 00 00 00  18 00 18 00 7C 00 00 00  SSP..... ....|...
  [020] 18 00 18 00 94 00 00 00  0E 00 0E 00 58 00 00 00  ........ ....X...
  [030] 08 00 08 00 66 00 00 00  0E 00 0E 00 6E 00 00 00  ....f... ....n...
  [040] 10 00 10 00 AC 00 00 00  15 82 88 E2 06 01 B1 1D  ........ ........
  [050] 00 00 00 0F 21 51 2D 5C  94 2D E0 EB 76 86 98 CC  ....!Q-\ .-..v...
  [060] CF F0 83 2B 65 00 43 00  53 00 53 00 65 00 72 00  ...+e.C. S.S.e.r.
  [070] 76 00 72 00 6F 00 6F 00  74 00 37 00 43 00 4C 00  v.r.o.o. t.7.C.L.
  [080] 49 00 45 00 4E 00 54 00  3B 89 87 7D 6F 09 DC 9D  I.E.N.T. ;..}o...
  [090] 00 00 00 00 00 00 00 00  00 00 00 00 00 00 00 00  ........ ........
  [0A0] 01 AA 8C 77 EB 06 01 48  CF 30 D9 11 05 CB A3 8D  ...w...H .0......
  [0B0] D5 CE CF 93 BC 45 14 AC  CF 59 84 C1 40 86 8B 28  .....E.. .Y..@..(
  [0C0] C6 84 8F EE 94 FC 6C 55  00 00 00 00 00           ......lU .....
[2012/05/25 11:40:08,  3] smbd/process.c:switch_message(1393)
  switch message SMBsesssetupX (pid 95) conn 0x0
[2012/05/25 11:40:08,  3] smbd/sec_ctx.c:set_sec_ctx(329)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2012/05/25 11:40:08,  5] auth/token_util.c:debug_nt_user_token(522)
  NT user token: (NULL)
[2012/05/25 11:40:08,  5] auth/token_util.c:debug_unix_user_token(548)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2012/05/25 11:40:08,  5] smbd/uid.c:change_to_root_user(370)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2012/05/25 11:40:08,  3] smbd/sesssetup.c:reply_sesssetup_and_X(1416)
  wct=12 flg2=0xc817
[2012/05/25 11:40:08,  2] smbd/sesssetup.c:setup_new_vc_session(1372)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2012/05/25 11:40:08,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1179)
  Doing spnego session setup
[2012/05/25 11:40:08,  3] smbd/sesssetup.c:reply_sesssetup_and_X_spnego(1214)
  NativeOS=[] NativeLanMan=[] PrimaryDomain=[]
[2012/05/25 11:40:08, 10] smbd/sesssetup.c:check_spnego_blob_complete(1127)
  check_spnego_blob_complete: needed_len = 200, pblob->length = 200
[2012/05/25 11:40:08,  3] libsmb/ntlmssp.c:ntlmssp_server_auth(747)
  Got user=[root] domain=[eCSServ] workstation=[7CLIENT] len1=24 len2=24
[2012/05/25 11:40:08,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(68)
  auth_context challenge set by NTLMSSP callback (NTLM2)
[2012/05/25 11:40:08,  5] auth/auth_ntlmssp.c:auth_ntlmssp_set_challenge(69)
  challenge is: 
[2012/05/25 11:40:08,  5] lib/util.c:dump_data(2268)
  [000] 8F D9 DB D2 58 69 1C A6                           ....Xi.. 
