[2009/09/08 12:43:28,  6] param/loadparm.c:6989(lp_file_list_changed)
  lp_file_list_changed()
  file /usr/etc/samba/smb.conf -> /usr/etc/samba/smb.conf  last mod_time: Tue Sep  8 12:42:53 2009
  
[2009/09/08 12:43:28,  3] smbd/oplock.c:911(init_oplocks)
  init_oplocks: initializing messages.
[2009/09/08 12:43:28,  3] smbd/oplock_linux.c:219(linux_init_kernel_oplocks)
  Linux kernel oplocks enabled
[2009/09/08 12:43:28, 10] lib/events.c:287(s3_event_debug)
  s3_event: Added timed event "smbd_idle_event_handler": 0x807480a0
[2009/09/08 12:43:28, 10] smbd/process.c:698(event_add_idle)
  event_add_idle: idle_evt(keepalive) 0x807480a0
[2009/09/08 12:43:28, 10] lib/events.c:287(s3_event_debug)
  s3_event: Added timed event "smbd_idle_event_handler": 0x8073ef98
[2009/09/08 12:43:28, 10] smbd/process.c:698(event_add_idle)
  event_add_idle: idle_evt(deadtime) 0x8073ef98
[2009/09/08 12:43:28, 10] lib/events.c:287(s3_event_debug)
  s3_event: Added timed event "smbd_idle_event_handler": 0x8073ec10
[2009/09/08 12:43:28, 10] smbd/process.c:698(event_add_idle)
  event_add_idle: idle_evt(housekeeping) 0x8073ec10
[2009/09/08 12:43:28, 10] lib/util_sock.c:781(read_smb_length_return_keepalive)
  got smb length of 68
[2009/09/08 12:43:28,  6] smbd/process.c:1430(process_smb)
  got message type 0x81 of len 0x44
[2009/09/08 12:43:28,  3] smbd/process.c:1433(process_smb)
  Transaction 0 of length 72 (0 toread)
[2009/09/08 12:43:28,  2] smbd/reply.c:451(reply_special)
  netbios connect: name1=MOTOKO          name2=PRODUZIONE3    
[2009/09/08 12:43:28,  2] smbd/reply.c:458(reply_special)
  netbios connect: local=motoko remote=produzione3, name type = 0
[2009/09/08 12:43:28,  6] param/loadparm.c:6989(lp_file_list_changed)
  lp_file_list_changed()
  file /usr/etc/samba/smb.conf -> /usr/etc/samba/smb.conf  last mod_time: Tue Sep  8 12:42:53 2009
  
[2009/09/08 12:43:28,  5] smbd/reply.c:498(reply_special)
  init msg_type=0x81 msg_flags=0x0
[2009/09/08 12:43:28, 10] lib/util_sock.c:781(read_smb_length_return_keepalive)
  got smb length of 154
[2009/09/08 12:43:28,  6] smbd/process.c:1430(process_smb)
  got message type 0x0 of len 0x9a
[2009/09/08 12:43:28,  3] smbd/process.c:1433(process_smb)
  Transaction 0 of length 158 (0 toread)
[2009/09/08 12:43:28,  5] lib/util.c:632(show_msg)
[2009/09/08 12:43:28,  5] lib/util.c:642(show_msg)
  size=154
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=0
  smb_flg2=0
  smb_tid=0
  smb_pid=7145
  smb_uid=0
  smb_mid=3329
  smt_wct=0
  smb_bcc=119
[2009/09/08 12:43:28, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 02 50 43 20 4E 45 54 57   4F 52 4B 20 50 52 4F 47   .PC NETW ORK PROG
  [0010] 52 41 4D 20 31 2E 30 00   02 4D 49 43 52 4F 53 4F   RAM 1.0. .MICROSO
  [0020] 46 54 20 4E 45 54 57 4F   52 4B 53 20 33 2E 30 00   FT NETWO RKS 3.0.
  [0030] 02 44 4F 53 20 4C 4D 31   2E 32 58 30 30 32 00 02   .DOS LM1 .2X002..
  [0040] 44 4F 53 20 4C 41 4E 4D   41 4E 32 2E 31 00 02 57   DOS LANM AN2.1..W
  [0050] 69 6E 64 6F 77 73 20 66   6F 72 20 57 6F 72 6B 67   indows f or Workg
  [0060] 72 6F 75 70 73 20 33 2E   31 61 00 02 4E 54 20 4C   roups 3. 1a..NT L
  [0070] 4D 20 30 2E 31 32 00                              M 0.12. 
[2009/09/08 12:43:28,  3] smbd/process.c:1251(switch_message)
  switch message SMBnegprot (pid 1243) conn 0x0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  5] smbd/uid.c:368(change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2009/09/08 12:43:28,  3] smbd/negprot.c:567(reply_negprot)
  Requested protocol [PC NETWORK PROGRAM 1.0]
[2009/09/08 12:43:28,  3] smbd/negprot.c:567(reply_negprot)
  Requested protocol [MICROSOFT NETWORKS 3.0]
[2009/09/08 12:43:28,  3] smbd/negprot.c:567(reply_negprot)
  Requested protocol [DOS LM1.2X002]
[2009/09/08 12:43:28,  3] smbd/negprot.c:567(reply_negprot)
  Requested protocol [DOS LANMAN2.1]
[2009/09/08 12:43:28,  3] smbd/negprot.c:567(reply_negprot)
  Requested protocol [Windows for Workgroups 3.1a]
[2009/09/08 12:43:28,  3] smbd/negprot.c:567(reply_negprot)
  Requested protocol [NT LM 0.12]
[2009/09/08 12:43:28, 10] lib/util.c:1979(set_remote_arch)
  set_remote_arch: Client arch is 'Win95'
[2009/09/08 12:43:28,  6] param/loadparm.c:6989(lp_file_list_changed)
  lp_file_list_changed()
  file /usr/etc/samba/smb.conf -> /usr/etc/samba/smb.conf  last mod_time: Tue Sep  8 12:42:53 2009
  
[2009/09/08 12:43:28,  5] smbd/connection.c:142(claim_connection)
  claiming []
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key DB040000FFFFFFFF0000
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80752330
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key DB040000FFFFFFFF0000
[2009/09/08 12:43:28,  6] param/loadparm.c:6989(lp_file_list_changed)
  lp_file_list_changed()
  file /usr/etc/samba/smb.conf -> /usr/etc/samba/smb.conf  last mod_time: Tue Sep  8 12:42:53 2009
  
[2009/09/08 12:43:28, 10] smbd/negprot.c:38(get_challenge)
  get challenge: creating negprot_global_auth_context
[2009/09/08 12:43:28,  5] auth/auth.c:487(make_auth_context_subsystem)
  Making default auth method list for DC, security=user, encrypt passwords = yes
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend sam
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'sam'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend sam_ignoredomain
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'sam_ignoredomain'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend unix
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'unix'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend winbind
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'winbind'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend wbc
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'wbc'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend smbserver
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'smbserver'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend trustdomain
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'trustdomain'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend ntdomain
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'ntdomain'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend guest
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'guest'
[2009/09/08 12:43:28,  5] auth/auth.c:46(smb_register_auth)
  Attempting to register auth backend netlogond
[2009/09/08 12:43:28,  5] auth/auth.c:58(smb_register_auth)
  Successfully added auth method 'netlogond'
[2009/09/08 12:43:28,  5] auth/auth.c:389(load_auth_module)
  load_auth_module: Attempting to find an auth method to match guest
[2009/09/08 12:43:28,  5] auth/auth.c:414(load_auth_module)
  load_auth_module: auth method guest has a valid init
[2009/09/08 12:43:28,  5] auth/auth.c:389(load_auth_module)
  load_auth_module: Attempting to find an auth method to match sam
[2009/09/08 12:43:28,  5] auth/auth.c:414(load_auth_module)
  load_auth_module: auth method sam has a valid init
[2009/09/08 12:43:28,  5] auth/auth.c:389(load_auth_module)
  load_auth_module: Attempting to find an auth method to match winbind:trustdomain
[2009/09/08 12:43:28,  5] auth/auth.c:389(load_auth_module)
  load_auth_module: Attempting to find an auth method to match trustdomain
[2009/09/08 12:43:28,  5] auth/auth.c:414(load_auth_module)
  load_auth_module: auth method trustdomain has a valid init
[2009/09/08 12:43:28,  5] auth/auth.c:414(load_auth_module)
  load_auth_module: auth method winbind has a valid init
[2009/09/08 12:43:28, 10] smbd/negprot.c:43(get_challenge)
  get challenge: getting challenge
[2009/09/08 12:43:28,  5] auth/auth.c:98(get_ntlm_challenge)
  auth_get_challenge: module guest did not want to specify a challenge
[2009/09/08 12:43:28,  5] auth/auth.c:98(get_ntlm_challenge)
  auth_get_challenge: module sam did not want to specify a challenge
[2009/09/08 12:43:28,  5] auth/auth.c:98(get_ntlm_challenge)
  auth_get_challenge: module winbind did not want to specify a challenge
[2009/09/08 12:43:28,  5] auth/auth.c:138(get_ntlm_challenge)
  auth_context challenge created by random
[2009/09/08 12:43:28,  5] auth/auth.c:139(get_ntlm_challenge)
  challenge is: 
[2009/09/08 12:43:28,  5] ../lib/util/util.c:304(_dump_data)
  [0000] 18 AD 0F D2 BC 1B F7 55                            .......U 
[2009/09/08 12:43:28,  3] smbd/negprot.c:368(reply_nt1)
  not using SPNEGO
[2009/09/08 12:43:28,  3] smbd/negprot.c:672(reply_negprot)
  Selected protocol NT LM 0.12
[2009/09/08 12:43:28,  5] smbd/negprot.c:679(reply_negprot)
  negprot index=5
[2009/09/08 12:43:28,  5] lib/util.c:632(show_msg)
[2009/09/08 12:43:28,  5] lib/util.c:642(show_msg)
  size=95
  smb_com=0x72
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=128
  smb_flg2=16385
  smb_tid=0
  smb_pid=7145
  smb_uid=0
  smb_mid=3329
  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]=56064 (0xDB00)
  smb_vwv[ 8]=    4 (0x4)
  smb_vwv[ 9]=64768 (0xFD00)
  smb_vwv[10]=33011 (0x80F3)
  smb_vwv[11]=    0 (0x0)
  smb_vwv[12]= 5640 (0x1608)
  smb_vwv[13]=28979 (0x7133)
  smb_vwv[14]=51760 (0xCA30)
  smb_vwv[15]=34817 (0x8801)
  smb_vwv[16]= 2303 (0x8FF)
  smb_bcc=8
[2009/09/08 12:43:28, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 18 AD 0F D2 BC 1B F7 55                            .......U 
[2009/09/08 12:43:28, 10] lib/util_sock.c:781(read_smb_length_return_keepalive)
  got smb length of 149
[2009/09/08 12:43:28,  6] smbd/process.c:1430(process_smb)
  got message type 0x0 of len 0x95
[2009/09/08 12:43:28,  3] smbd/process.c:1433(process_smb)
  Transaction 1 of length 153 (0 toread)
[2009/09/08 12:43:28,  5] lib/util.c:632(show_msg)
[2009/09/08 12:43:28,  5] lib/util.c:642(show_msg)
  size=149
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=16
  smb_flg2=4096
  smb_tid=0
  smb_pid=7145
  smb_uid=1
  smb_mid=3329
  smt_wct=13
  smb_vwv[ 0]=  117 (0x75)
  smb_vwv[ 1]=  117 (0x75)
  smb_vwv[ 2]= 2920 (0xB68)
  smb_vwv[ 3]=   50 (0x32)
  smb_vwv[ 4]=    0 (0x0)
  smb_vwv[ 5]= 1243 (0x4DB)
  smb_vwv[ 6]=    0 (0x0)
  smb_vwv[ 7]=   24 (0x18)
  smb_vwv[ 8]=    0 (0x0)
  smb_vwv[ 9]=    0 (0x0)
  smb_vwv[10]=    0 (0x0)
  smb_vwv[11]=    5 (0x5)
  smb_vwv[12]=    0 (0x0)
  smb_bcc=56
[2009/09/08 12:43:28, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 87 5E D6 1A DB 20 F5 B5   90 D1 4F 2D F1 AA 9C 5F   .^... .. ..O-..._
  [0010] 2B 6B B4 E1 AF 0D C7 ED   4D 52 43 4C 4E 5A 00 00   +k...... MRCLNZ..
  [0020] 57 69 6E 64 6F 77 73 20   34 2E 30 00 57 69 6E 64   Windows  4.0.Wind
  [0030] 6F 77 73 20 34 2E 30 00                            ows 4.0. 
[2009/09/08 12:43:28,  3] smbd/process.c:1251(switch_message)
  switch message SMBsesssetupX (pid 1243) conn 0x0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  5] smbd/uid.c:368(change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2009/09/08 12:43:28,  3] smbd/sesssetup.c:1404(reply_sesssetup_and_X)
  wct=13 flg2=0x1000
[2009/09/08 12:43:28, 10] lib/util.c:1979(set_remote_arch)
  set_remote_arch: Client arch is 'Win95'
[2009/09/08 12:43:28,  3] smbd/sesssetup.c:1607(reply_sesssetup_and_X)
  Domain=[]  NativeOS=[Windows 4.0] NativeLanMan=[Windows 4.0] PrimaryDomain=[null]
[2009/09/08 12:43:28,  2] smbd/sesssetup.c:1360(setup_new_vc_session)
  setup_new_vc_session: New VC == 0, if NT4.x compatible we would close all old resources.
[2009/09/08 12:43:28,  3] smbd/sesssetup.c:1623(reply_sesssetup_and_X)
  sesssetupX:name=[]\[MRCLNZ]@[produzione3]
[2009/09/08 12:43:28,  6] param/loadparm.c:6989(lp_file_list_changed)
  lp_file_list_changed()
  file /usr/etc/samba/smb.conf -> /usr/etc/samba/smb.conf  last mod_time: Tue Sep  8 12:42:53 2009
  
[2009/09/08 12:43:28,  5] auth/auth_util.c:208(make_user_info_map)
  Mapping user []\[MRCLNZ] from workstation [produzione3]
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  5] auth/auth_util.c:2184(is_trusted_domain)
  is_trusted_domain: Checking for domain trust with []
[2009/09/08 12:43:28,  5] passdb/secrets.c:669(secrets_fetch_trusted_domain_password)
  secrets_fetch failed!
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = TDOM/ couldn't be found
[2009/09/08 12:43:28,  5] libsmb/trustdom_cache.c:183(trustdom_cache_fetch)
  no entry for trusted domain  found.
[2009/09/08 12:43:28,  5] auth/auth_util.c:229(make_user_info_map)
  Mapped domain from [] to [LOGOSTEC] for user [MRCLNZ] from workstation [produzione3]
[2009/09/08 12:43:28,  5] auth/auth_util.c:120(make_user_info)
  attempting to make a user_info for MRCLNZ (MRCLNZ)
[2009/09/08 12:43:28,  5] auth/auth_util.c:130(make_user_info)
  making strings for MRCLNZ's user_info struct
[2009/09/08 12:43:28,  5] auth/auth_util.c:162(make_user_info)
  making blobs for MRCLNZ's user_info struct
[2009/09/08 12:43:28, 10] auth/auth_util.c:180(make_user_info)
  made an encrypted user_info for MRCLNZ (MRCLNZ)
[2009/09/08 12:43:28,  3] auth/auth.c:222(check_ntlm_password)
  check_ntlm_password:  Checking password for unmapped user []\[MRCLNZ]@[produzione3] with the new password interface
[2009/09/08 12:43:28,  3] auth/auth.c:225(check_ntlm_password)
  check_ntlm_password:  mapped user is: [LOGOSTEC]\[MRCLNZ]@[produzione3]
[2009/09/08 12:43:28, 10] auth/auth.c:234(check_ntlm_password)
  check_ntlm_password: auth_context challenge created by random
[2009/09/08 12:43:28, 10] auth/auth.c:236(check_ntlm_password)
  challenge is: 
[2009/09/08 12:43:28,  5] ../lib/util/util.c:304(_dump_data)
  [0000] 18 AD 0F D2 BC 1B F7 55                            .......U 
[2009/09/08 12:43:28, 10] auth/auth.c:262(check_ntlm_password)
  check_ntlm_password: guest had nothing to say
[2009/09/08 12:43:28,  8] lib/util.c:1879(is_myname)
  is_myname("LOGOSTEC") returns 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:572(pdb_set_username)
  pdb_set_username: setting username mrclnz, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:595(pdb_set_domain)
  pdb_set_domain: setting domain LOGOSTEC, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:618(pdb_set_nt_username)
  pdb_set_nt_username: setting nt username , was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:641(pdb_set_fullname)
  pdb_set_full_name: setting full name Lorenzo Marcantonio, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:734(pdb_set_homedir)
  pdb_set_homedir: setting home dir \\motoko\mrclnz\w98profile, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:710(pdb_set_dir_drive)
  pdb_set_dir_drive: setting dir drive z:, was NULL
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:664(pdb_set_logon_script)
  pdb_set_logon_script: setting logon script nlogon.bat, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:687(pdb_set_profile_path)
  pdb_set_profile_path: setting profile path \\motoko\profiles\mrclnz, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:777(pdb_set_workstations)
  pdb_set_workstations: setting workstations , was 
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] lib/account_pol.c:333(account_policy_get)
  account_policy_get: name: password history, val: 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:501(pdb_set_user_sid)
  pdb_set_user_sid: setting user sid S-1-5-21-3505275195-4163401244-3109209186-3000
[2009/09/08 12:43:28, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid)
  pdb_set_user_sid_from_rid:
  	setting user sid S-1-5-21-3505275195-4163401244-3109209186-3000 from rid 3000
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] lib/account_pol.c:333(account_policy_get)
  account_policy_get: name: maximum password age, val: -1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] lib/username.c:133(Get_Pwnam_alloc)
  Finding user mrclnz
[2009/09/08 12:43:28,  5] lib/username.c:77(Get_Pwnam_internals)
  Trying _Get_Pwnam(), username as lowercase is mrclnz
[2009/09/08 12:43:28,  5] lib/username.c:110(Get_Pwnam_internals)
  Get_Pwnam_internals did find user [mrclnz]!
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] lib/account_pol.c:333(account_policy_get)
  account_policy_get: name: password history, val: 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:572(pdb_set_username)
  pdb_set_username: setting username mrclnz, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:595(pdb_set_domain)
  pdb_set_domain: setting domain LOGOSTEC, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:618(pdb_set_nt_username)
  pdb_set_nt_username: setting nt username , was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:641(pdb_set_fullname)
  pdb_set_full_name: setting full name Lorenzo Marcantonio, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:734(pdb_set_homedir)
  pdb_set_homedir: setting home dir \\motoko\mrclnz\w98profile, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:710(pdb_set_dir_drive)
  pdb_set_dir_drive: setting dir drive z:, was NULL
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:664(pdb_set_logon_script)
  pdb_set_logon_script: setting logon script nlogon.bat, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:687(pdb_set_profile_path)
  pdb_set_profile_path: setting profile path \\motoko\profiles\mrclnz, was 
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:777(pdb_set_workstations)
  pdb_set_workstations: setting workstations , was 
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] lib/account_pol.c:333(account_policy_get)
  account_policy_get: name: password history, val: 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/pdb_get_set.c:501(pdb_set_user_sid)
  pdb_set_user_sid: setting user sid S-1-5-21-3505275195-4163401244-3109209186-3000
[2009/09/08 12:43:28, 10] passdb/pdb_compat.c:72(pdb_set_user_sid_from_rid)
  pdb_set_user_sid_from_rid:
  	setting user sid S-1-5-21-3505275195-4163401244-3109209186-3000 from rid 3000
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  9] passdb/passdb.c:2142(pdb_update_autolock_flag)
  pdb_update_autolock_flag: Account mrclnz not autolocked, no check needed
[2009/09/08 12:43:28,  4] libsmb/ntlm_check.c:379(ntlm_password_check)
  ntlm_password_check: Checking LM password
[2009/09/08 12:43:28,  4] auth/auth_sam.c:137(sam_account_ok)
  sam_account_ok: Checking SMB password for user mrclnz
[2009/09/08 12:43:28,  5] auth/auth_sam.c:119(logon_hours_ok)
  logon_hours_ok: user mrclnz allowed to logon at this time (Tue Sep  8 10:43:28 2009
  )
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] lib/account_pol.c:333(account_policy_get)
  account_policy_get: name: maximum password age, val: -1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] lib/system_smbd.c:122(sys_getgrouplist)
  sys_getgrouplist: user [mrclnz]
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/GID2SID/1000 couldn't be found
[2009/09/08 12:43:28,  5] passdb/lookup_sid.c:1378(gid_to_sid)
  gid_to_sid: winbind failed to find a sid for gid 1000
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1173(legacy_gid_to_sid)
  LEGACY: gid 1000 -> sid S-1-22-2-1000
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/GID2SID/25 couldn't be found
[2009/09/08 12:43:28,  5] passdb/lookup_sid.c:1378(gid_to_sid)
  gid_to_sid: winbind failed to find a sid for gid 25
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1173(legacy_gid_to_sid)
  LEGACY: gid 25 -> sid S-1-22-2-25
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/GID2SID/995 couldn't be found
[2009/09/08 12:43:28,  5] passdb/lookup_sid.c:1378(gid_to_sid)
  gid_to_sid: winbind failed to find a sid for gid 995
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1173(legacy_gid_to_sid)
  LEGACY: gid 995 -> sid S-1-22-2-995
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/GID2SID/996 couldn't be found
[2009/09/08 12:43:28,  5] passdb/lookup_sid.c:1378(gid_to_sid)
  gid_to_sid: winbind failed to find a sid for gid 996
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1173(legacy_gid_to_sid)
  LEGACY: gid 996 -> sid S-1-22-2-996
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/GID2SID/999 couldn't be found
[2009/09/08 12:43:28,  5] passdb/lookup_sid.c:1378(gid_to_sid)
  gid_to_sid: winbind failed to find a sid for gid 999
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1173(legacy_gid_to_sid)
  LEGACY: gid 999 -> sid S-1-5-21-3505275195-4163401244-3109209186-2999
[2009/09/08 12:43:28,  5] auth/auth_util.c:646(make_server_info_sam)
  make_server_info_sam: made server info for user mrclnz -> mrclnz
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] auth/auth.c:271(check_ntlm_password)
  check_ntlm_password: sam authentication for user [MRCLNZ] succeeded
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  5] auth/auth.c:297(check_ntlm_password)
  check_ntlm_password:  PAM Account for user [mrclnz] succeeded
[2009/09/08 12:43:28,  2] auth/auth.c:310(check_ntlm_password)
  check_ntlm_password:  authentication for user [MRCLNZ] -> [MRCLNZ] -> [mrclnz] succeeded
[2009/09/08 12:43:28,  5] auth/auth_util.c:2114(free_user_info)
  attempting to free (and zero) a user_info structure
[2009/09/08 12:43:28, 10] auth/auth_util.c:2118(free_user_info)
  structure was created for MRCLNZ
[2009/09/08 12:43:28, 10] auth/token_util.c:353(create_local_nt_token)
  Create local NT token for S-1-5-21-3505275195-4163401244-3109209186-3000
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/SID2GID/S-1-5-32-544 couldn't be found
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1502(sid_to_gid)
  winbind failed to find a gid for sid S-1-5-32-544
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1247(legacy_sid_to_gid)
  LEGACY: mapping failed for sid S-1-5-32-544
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/SID2GID/S-1-5-32-544 couldn't be found
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1502(sid_to_gid)
  winbind failed to find a gid for sid S-1-5-32-544
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1247(legacy_sid_to_gid)
  LEGACY: mapping failed for sid S-1-5-32-544
[2009/09/08 12:43:28,  5] auth/token_util.c:303(create_builtin_administrators)
  create_builtin_administrators: Failed to create Administrators
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-21-3505275195-4163401244-3109209186-3000]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-22-2-1000]
[2009/09/08 12:43:28,  5] lib/privileges.c:128(get_privileges_for_sids)
  get_privileges_for_sids: sid = S-1-1-0
  Privilege set:
  SE_PRIV  0x0 0x0 0x0 0x0
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-2]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-11]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-21-3505275195-4163401244-3109209186-512]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-22-2-25]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-32-545]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-22-2-995]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-22-2-996]
[2009/09/08 12:43:28,  3] lib/privileges.c:63(get_privileges)
  get_privileges: No privileges assigned to SID [S-1-5-21-3505275195-4163401244-3109209186-2999]
[2009/09/08 12:43:28,  5] lib/privileges.c:128(get_privileges_for_sids)
  get_privileges_for_sids: sid = S-1-5-32-544
  Privilege set:
  SE_PRIV  0xff0 0x0 0x0 0x0
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/SID2GID/S-1-1-0 couldn't be found
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1502(sid_to_gid)
  winbind failed to find a gid for sid S-1-1-0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1247(legacy_sid_to_gid)
  LEGACY: mapping failed for sid S-1-1-0
[2009/09/08 12:43:28, 10] auth/auth_util.c:750(create_local_token)
  Could not convert SID S-1-1-0 to gid, ignoring it
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/SID2GID/S-1-5-2 couldn't be found
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1502(sid_to_gid)
  winbind failed to find a gid for sid S-1-5-2
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1247(legacy_sid_to_gid)
  LEGACY: mapping failed for sid S-1-5-2
[2009/09/08 12:43:28, 10] auth/auth_util.c:750(create_local_token)
  Could not convert SID S-1-5-2 to gid, ignoring it
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/SID2GID/S-1-5-11 couldn't be found
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1502(sid_to_gid)
  winbind failed to find a gid for sid S-1-5-11
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1247(legacy_sid_to_gid)
  LEGACY: mapping failed for sid S-1-5-11
[2009/09/08 12:43:28, 10] auth/auth_util.c:750(create_local_token)
  Could not convert SID S-1-5-11 to gid, ignoring it
[2009/09/08 12:43:28, 10] lib/gencache.c:194(gencache_get)
  Cache entry with key = IDMAP/SID2GID/S-1-5-32-544 couldn't be found
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1502(sid_to_gid)
  winbind failed to find a gid for sid S-1-5-32-544
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:210(push_sec_ctx)
  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  3] smbd/uid.c:428(push_conn_ctx)
  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28, 10] passdb/lookup_sid.c:1247(legacy_sid_to_gid)
  LEGACY: mapping failed for sid S-1-5-32-544
[2009/09/08 12:43:28, 10] auth/auth_util.c:750(create_local_token)
  Could not convert SID S-1-5-32-544 to gid, ignoring it
[2009/09/08 12:43:28, 10] auth/token_util.c:528(debug_nt_user_token)
  NT user token of user S-1-5-21-3505275195-4163401244-3109209186-3000
  contains 16 SIDs
  SID[  0]: S-1-5-21-3505275195-4163401244-3109209186-3000
  SID[  1]: S-1-22-2-1000
  SID[  2]: S-1-1-0
  SID[  3]: S-1-5-2
  SID[  4]: S-1-5-11
  SID[  5]: S-1-5-21-3505275195-4163401244-3109209186-512
  SID[  6]: S-1-22-2-25
  SID[  7]: S-1-5-32-545
  SID[  8]: S-1-22-2-995
  SID[  9]: S-1-22-2-996
  SID[ 10]: S-1-5-21-3505275195-4163401244-3109209186-2999
  SID[ 11]: S-1-5-32-544
  SID[ 12]: S-1-22-1-1000
  SID[ 13]: S-1-22-2-0
  SID[ 14]: S-1-22-2-97
  SID[ 15]: S-1-22-2-999
  SE_PRIV  0xff0 0x0 0x0 0x0
[2009/09/08 12:43:28, 10] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 1000
  Primary group is 1000 and contains 7 supplementary groups
  Group[  0]: 1000
  Group[  1]: 0
  Group[  2]: 25
  Group[  3]: 97
  Group[  4]: 995
  Group[  5]: 996
  Group[  6]: 999
[2009/09/08 12:43:28, 10] smbd/password.c:172(register_initial_vuid)
  register_initial_vuid: allocated vuid = 100
[2009/09/08 12:43:28, 10] smbd/password.c:265(register_existing_vuid)
  register_existing_vuid: (1000,1000) mrclnz MRCLNZ LOGOSTEC guest=0
[2009/09/08 12:43:28,  3] smbd/password.c:269(register_existing_vuid)
  register_existing_vuid: User name: mrclnz	Real name: Lorenzo Marcantonio
[2009/09/08 12:43:28,  3] smbd/password.c:279(register_existing_vuid)
  register_existing_vuid: UNIX uid 1000 is UNIX user mrclnz, and will be vuid 100
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3100
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80743b80
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3100
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3200
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80743b80
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3200
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3300
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80743b80
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3300
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3400
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80743b80
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3400
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3500
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80743b80
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3500
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3600
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80743b80
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3600
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3700
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x8074b560
[2009/09/08 12:43:28,  1] smbd/session.c:111(session_claim)
  Re-using invalid record
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3700
[2009/09/08 12:43:28,  2] smbd/utmp.c:437(sys_utmp_update)
  utmp_update: uname:/var/run/utmp wname:/var/log/wtmp
[2009/09/08 12:43:28,  7] param/loadparm.c:9251(lp_servicenumber)
  lp_servicenumber: couldn't find mrclnz
[2009/09/08 12:43:28,  3] smbd/password.c:211(register_homes_share)
  Adding homes service for user 'mrclnz' using home directory: '/home/mrclnz'
[2009/09/08 12:43:28,  8] param/loadparm.c:6024(add_a_service)
  add_a_service: Creating snum = 17 for mrclnz
[2009/09/08 12:43:28, 10] param/loadparm.c:6071(hash_a_service)
  hash_a_service: hashing index 17 for service name mrclnz
[2009/09/08 12:43:28,  3] param/loadparm.c:6121(lp_add_home)
  adding home's share [mrclnz] for user 'mrclnz' at '/home/mrclnz'
[2009/09/08 12:43:28,  6] param/loadparm.c:6989(lp_file_list_changed)
  lp_file_list_changed()
  file /usr/etc/samba/smb.conf -> /usr/etc/samba/smb.conf  last mod_time: Tue Sep  8 12:42:53 2009
  
[2009/09/08 12:43:28,  3] smbd/process.c:1251(switch_message)
  switch message SMBtconX (pid 1243) conn 0x0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  5] smbd/uid.c:368(change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2009/09/08 12:43:28,  4] smbd/reply.c:675(reply_tcon_and_X)
  Client requested device type [?????] for share [IPC$]
[2009/09/08 12:43:28,  1] smbd/service.c:1106(make_connection)
  make_connection: refusing to connect with no session setup
[2009/09/08 12:43:28,  3] smbd/error.c:79(error_packet_set)
  error packet at smbd/reply.c(684) cmd=117 (SMBtconX) eclass=1 ecode=5
[2009/09/08 12:43:28,  5] lib/util.c:632(show_msg)
[2009/09/08 12:43:28,  5] lib/util.c:642(show_msg)
  size=71
  smb_com=0x73
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=128
  smb_flg2=1
  smb_tid=0
  smb_pid=7145
  smb_uid=100
  smb_mid=3329
  smt_wct=3
  smb_vwv[ 0]=  117 (0x75)
  smb_vwv[ 1]=   68 (0x44)
  smb_vwv[ 2]=    0 (0x0)
  smb_bcc=26
[2009/09/08 12:43:28, 10] ../lib/util/util.c:304(_dump_data)
  [0000] 55 6E 69 78 00 53 61 6D   62 61 20 33 2E 34 2E 30   Unix.Sam ba 3.4.0
  [0010] 00 4C 4F 47 4F 53 54 45   43 00                    .LOGOSTE C.
[2009/09/08 12:43:28, 10] lib/util_sock.c:781(read_smb_length_return_keepalive)
  got smb length of 35
[2009/09/08 12:43:28,  6] smbd/process.c:1430(process_smb)
  got message type 0x0 of len 0x23
[2009/09/08 12:43:28,  3] smbd/process.c:1433(process_smb)
  Transaction 2 of length 39 (0 toread)
[2009/09/08 12:43:28,  5] lib/util.c:632(show_msg)
[2009/09/08 12:43:28,  5] lib/util.c:642(show_msg)
  size=35
  smb_com=0x71
  smb_rcls=0
  smb_reh=0
  smb_err=0
  smb_flg=0
  smb_flg2=32769
  smb_tid=0
  smb_pid=7145
  smb_uid=100
  smb_mid=3585
  smt_wct=0
  smb_bcc=0
[2009/09/08 12:43:28,  3] smbd/process.c:1251(switch_message)
  switch message SMBtdis (pid 1243) conn 0x0
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  5] smbd/uid.c:368(change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2009/09/08 12:43:28,  4] smbd/reply.c:4705(reply_tdis)
  Invalid connection in tdis
[2009/09/08 12:43:28,  3] smbd/error.c:79(error_packet_set)
  error packet at smbd/reply.c(4706) cmd=113 (SMBtdis) eclass=2 ecode=5
[2009/09/08 12:43:28,  5] lib/util.c:632(show_msg)
[2009/09/08 12:43:28,  5] lib/util.c:642(show_msg)
  size=35
  smb_com=0x71
  smb_rcls=2
  smb_reh=0
  smb_err=5
  smb_flg=128
  smb_flg2=32769
  smb_tid=0
  smb_pid=7145
  smb_uid=100
  smb_mid=3585
  smt_wct=0
  smb_bcc=0
[2009/09/08 12:43:28,  5] lib/util_sock.c:526(read_socket_with_timeout)
  read_socket_with_timeout: blocking read. EOF from client.
[2009/09/08 12:43:28, 10] smbd/process.c:271(receive_smb_raw_talloc)
  receive_smb_raw: NT_STATUS_END_OF_FILE
[2009/09/08 12:43:28,  3] smbd/sec_ctx.c:310(set_sec_ctx)
  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
[2009/09/08 12:43:28,  5] auth/token_util.c:522(debug_nt_user_token)
  NT user token: (NULL)
[2009/09/08 12:43:28,  5] auth/token_util.c:548(debug_unix_user_token)
  UNIX token of user 0
  Primary group is 0 and contains 0 supplementary groups
[2009/09/08 12:43:28,  5] smbd/uid.c:368(change_to_root_user)
  change_to_root_user: now uid=(0,0) gid=(0,0)
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key 49442F3700
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x80743b80
[2009/09/08 12:43:28,  2] smbd/utmp.c:437(sys_utmp_update)
  utmp_update: uname:/var/run/utmp wname:/var/log/wtmp
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key 49442F3700
[2009/09/08 12:43:28,  3] smbd/connection.c:31(yield_connection)
  Yielding connection to 
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
  Locking key DB040000FFFFFFFF0000
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
  Allocated locked data 0x0x807488f8
[2009/09/08 12:43:28, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
  Unlocking key DB040000FFFFFFFF0000
[2009/09/08 12:43:28,  3] smbd/server.c:844(exit_server_common)
  Server exit (failed to receive smb request)