Attachment 4735 Details for Bug 6555 – Client level 10 log on the member

Client level 10 log on the member

it-01.log (text/plain), 66.60 KB, created by Marc Muehlfeld (dead/inactive account) on 2009-09-24 02:16:58 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Marc Muehlfeld (dead/inactive account)

Created: 2009-09-24 02:16:58 UTC

Size: 66.60 KB

patch

obsolete

>[2009/09/24 09:06:23,  6] param/loadparm.c:6989(lp_file_list_changed)
>  lp_file_list_changed()
>  file /etc/samba/shares.conf -> /etc/samba/shares.conf  last mod_time: Wed Jul 15 16:15:19 2009
>  
>  file /etc/samba//smb.conf -> /etc/samba//smb.conf  last mod_time: Thu Sep 24 09:05:40 2009
>  
>[2009/09/24 09:06:23,  5] auth/auth_util.c:208(make_user_info_map)
>  Mapping user []\[] from workstation [IT-01]
>[2009/09/24 09:06:23,  5] auth/auth_util.c:229(make_user_info_map)
>  Mapped domain from [] to [NUCLEUS] for user [] from workstation [IT-01]
>[2009/09/24 09:06:23,  5] auth/auth_util.c:120(make_user_info)
>  attempting to make a user_info for  ()
>[2009/09/24 09:06:23,  5] auth/auth_util.c:130(make_user_info)
>  making strings for 's user_info struct
>[2009/09/24 09:06:23,  5] auth/auth_util.c:162(make_user_info)
>  making blobs for 's user_info struct
>[2009/09/24 09:06:23, 10] auth/auth_util.c:180(make_user_info)
>  made an encrypted user_info for  ()
>[2009/09/24 09:06:23,  3] auth/auth.c:222(check_ntlm_password)
>  check_ntlm_password:  Checking password for unmapped user []\[]@[IT-01] with the new password interface
>[2009/09/24 09:06:23,  3] auth/auth.c:225(check_ntlm_password)
>  check_ntlm_password:  mapped user is: [NUCLEUS]\[]@[IT-01]
>[2009/09/24 09:06:23, 10] auth/auth.c:234(check_ntlm_password)
>  check_ntlm_password: auth_context challenge created by random
>[2009/09/24 09:06:23, 10] auth/auth.c:236(check_ntlm_password)
>  challenge is: 
>[2009/09/24 09:06:23,  5] ../lib/util/util.c:304(_dump_data)
>  [0000] A4 A7 14 C9 99 85 C0 11                            ........ 
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:572(pdb_set_username)
>  pdb_set_username: setting username nobody, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:595(pdb_set_domain)
>  pdb_set_domain: setting domain NUCLEUS, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:618(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:641(pdb_set_fullname)
>  pdb_set_full_name: setting full name nobody, was 
>[2009/09/24 09:06:23,  4] lib/substitute.c:504(automount_server)
>  Home server: nucleus
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:734(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\nucleus\nobody, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:710(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:664(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2009/09/24 09:06:23,  4] lib/substitute.c:504(automount_server)
>  Home server: nucleus
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:687(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\nucleus\nobody\profile, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:777(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:501(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-3081873947-908747446-877470218-501
>[2009/09/24 09:06:23, 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-3081873947-908747446-877470218-501 from rid 501
>[2009/09/24 09:06:23,  3] auth/auth.c:271(check_ntlm_password)
>  check_ntlm_password: guest authentication for user [] succeeded
>[2009/09/24 09:06:23,  5] auth/auth.c:310(check_ntlm_password)
>  check_ntlm_password:  guest authentication for user [] -> [] -> [nobody] succeeded
>[2009/09/24 09:06:23,  5] auth/auth_util.c:2114(free_user_info)
>  attempting to free (and zero) a user_info structure
>[2009/09/24 09:06:23, 10] auth/auth_util.c:2118(free_user_info)
>  structure was created for 
>[2009/09/24 09:06:23, 10] auth/token_util.c:353(create_local_nt_token)
>  Create local NT token for S-1-5-21-3081873947-908747446-877470218-501
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-21-3081873947-908747446-877470218-501]
>[2009/09/24 09:06:23,  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/24 09:06:23,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-2]
>[2009/09/24 09:06:23,  3] lib/privileges.c:63(get_privileges)
>  get_privileges: No privileges assigned to SID [S-1-5-32-546]
>[2009/09/24 09:06:23, 10] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-3081873947-908747446-877470218-501
>  contains 8 SIDs
>  SID[  0]: S-1-5-21-3081873947-908747446-877470218-501
>  SID[  1]: S-1-1-0
>  SID[  2]: S-1-5-2
>  SID[  3]: S-1-5-32-546
>  SID[  4]: S-1-22-1-65534
>  SID[  5]: S-1-22-2-30061
>  SID[  6]: S-1-22-2-30036
>  SID[  7]: S-1-22-2-30086
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2009/09/24 09:06:23, 10] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 65534
>  Primary group is 65533 and contains 3 supplementary groups
>  Group[  0]: 30061
>  Group[  1]: 30036
>  Group[  2]: 30086
>[2009/09/24 09:06:23, 10] auth/auth_ntlmssp.c:139(auth_ntlmssp_check_password)
>  Got NT session key of length 16
>[2009/09/24 09:06:23, 10] auth/auth_ntlmssp.c:146(auth_ntlmssp_check_password)
>  Got LM session key of length 16
>[2009/09/24 09:06:23, 10] libsmb/ntlmssp.c:851(ntlmssp_server_auth)
>  ntlmssp_server_auth: Using unmodified nt session key.
>[2009/09/24 09:06:23,  3] libsmb/ntlmssp_sign.c:342(ntlmssp_sign_init)
>  NTLMSSP Sign/Seal - Initialising with flags:
>[2009/09/24 09:06:23,  3] libsmb/ntlmssp.c:62(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0xa2088205
>    NTLMSSP_NEGOTIATE_UNICODE
>    NTLMSSP_REQUEST_TARGET
>    NTLMSSP_NEGOTIATE_NTLM
>    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
>    NTLMSSP_NEGOTIATE_NTLM2
>    NTLMSSP_NEGOTIATE_VERSION
>    NTLMSSP_NEGOTIATE_128
>    NTLMSSP_NEGOTIATE_56
>[2009/09/24 09:06:23, 10] smbd/password.c:265(register_existing_vuid)
>  register_existing_vuid: (65534,65533) nobody  NUCLEUS guest=1
>[2009/09/24 09:06:23,  3] smbd/password.c:269(register_existing_vuid)
>  register_existing_vuid: User name: nobody	Real name: nobody
>[2009/09/24 09:06:23,  3] smbd/password.c:279(register_existing_vuid)
>  register_existing_vuid: UNIX uid 65534 is UNIX user nobody, and will be vuid 100
>[2009/09/24 09:06:23,  6] param/loadparm.c:6989(lp_file_list_changed)
>  lp_file_list_changed()
>  file /etc/samba/shares.conf -> /etc/samba/shares.conf  last mod_time: Wed Jul 15 16:15:19 2009
>  
>  file /etc/samba//smb.conf -> /etc/samba//smb.conf  last mod_time: Thu Sep 24 09:05:40 2009
>  
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=94
>  smb_com=0x73
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=100
>  smb_mid=128
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    1 (0x1)
>  smb_vwv[ 3]=    9 (0x9)
>  smb_bcc=51
>[2009/09/24 09:06:23, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] A1 07 30 05 A0 03 0A 01   00 55 00 6E 00 69 00 78   ..0..... .U.n.i.x
>  [0010] 00 00 00 53 00 61 00 6D   00 62 00 61 00 20 00 33   ...S.a.m .b.a. .3
>  [0020] 00 2E 00 34 00 2E 00 31   00 00 00 4D 00 55 00 43   ...4...1 ...M.U.C
>  [0030] 00 00 00                                          ... 
>[2009/09/24 09:06:23, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 80
>[2009/09/24 09:06:23,  6] smbd/process.c:1436(process_smb)
>  got message type 0x0 of len 0x50
>[2009/09/24 09:06:23,  3] smbd/process.c:1439(process_smb)
>  Transaction 3 of length 84 (0 toread)
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=80
>  smb_com=0x75
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=100
>  smb_mid=192
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=   80 (0x50)
>  smb_vwv[ 2]=    8 (0x8)
>  smb_vwv[ 3]=    1 (0x1)
>  smb_bcc=37
>[2009/09/24 09:06:23, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 5C 00 5C 00 4E 00 55   00 43 00 4C 00 45 00 55   .\.\.N.U .C.L.E.U
>  [0010] 00 53 00 5C 00 49 00 50   00 43 00 24 00 00 00 3F   .S.\.I.P .C.$...?
>  [0020] 3F 3F 3F 3F 00                                    ????. 
>[2009/09/24 09:06:23,  3] smbd/process.c:1252(switch_message)
>  switch message SMBtconX (pid 30972) conn 0x0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:23,  4] smbd/reply.c:675(reply_tcon_and_X)
>  Client requested device type [?????] for share [IPC$]
>[2009/09/24 09:06:23,  5] smbd/service.c:1198(make_connection)
>  making a connection to 'normal' service ipc$
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:572(pdb_set_username)
>  pdb_set_username: setting username nobody, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:595(pdb_set_domain)
>  pdb_set_domain: setting domain NUCLEUS, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:618(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:641(pdb_set_fullname)
>  pdb_set_full_name: setting full name nobody, was 
>[2009/09/24 09:06:23,  4] lib/substitute.c:504(automount_server)
>  Home server: nucleus
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:734(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\nucleus\nobody, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:710(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:664(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2009/09/24 09:06:23,  4] lib/substitute.c:504(automount_server)
>  Home server: nucleus
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:687(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\nucleus\nobody\profile, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:777(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:501(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-3081873947-908747446-877470218-501
>[2009/09/24 09:06:23, 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-3081873947-908747446-877470218-501 from rid 501
>[2009/09/24 09:06:23,  5] lib/username.c:133(Get_Pwnam_alloc)
>  Finding user nobody
>[2009/09/24 09:06:23,  5] lib/username.c:77(Get_Pwnam_internals)
>  Trying _Get_Pwnam(), username as lowercase is nobody
>[2009/09/24 09:06:23,  5] lib/username.c:110(Get_Pwnam_internals)
>  Get_Pwnam_internals did find user [nobody]!
>[2009/09/24 09:06:23, 10] smbd/service.c:158(set_conn_connectpath)
>  set_conn_connectpath: service IPC$, connectpath = /tmp
>[2009/09/24 09:06:23,  3] smbd/service.c:803(make_connection_snum)
>  Connect path is '/tmp' for service [IPC$]
>[2009/09/24 09:06:23, 10] lib/util_seaccess.c:58(se_map_generic)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2009/09/24 09:06:23,  3] smbd/vfs.c:95(vfs_init_default)
>  Initialising default vfs hooks
>[2009/09/24 09:06:23, 10] smbd/vfs.c:47(vfs_find_backend_entry)
>  vfs_find_backend_entry called for /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:85(smb_register_vfs)
>  Successfully added vfs backend '/[Default VFS]/'
>[2009/09/24 09:06:23,  3] smbd/vfs.c:129(vfs_init_custom)
>  Initialising custom vfs hooks from [/[Default VFS]/]
>[2009/09/24 09:06:23, 10] smbd/vfs.c:47(vfs_find_backend_entry)
>  vfs_find_backend_entry called for /[Default VFS]/
>  Successfully loaded vfs module [/[Default VFS]/] with the new modules system
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #0 (type 0, layer 0)
>  Making operation type 0 opaque [module /[Default VFS]/]
>  Accepting operation type 0 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #1 (type 1, layer 0)
>  Making operation type 1 opaque [module /[Default VFS]/]
>  Accepting operation type 1 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #2 (type 2, layer 0)
>  Making operation type 2 opaque [module /[Default VFS]/]
>  Accepting operation type 2 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #3 (type 3, layer 0)
>  Making operation type 3 opaque [module /[Default VFS]/]
>  Accepting operation type 3 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #4 (type 4, layer 0)
>  Making operation type 4 opaque [module /[Default VFS]/]
>  Accepting operation type 4 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #5 (type 5, layer 0)
>  Making operation type 5 opaque [module /[Default VFS]/]
>  Accepting operation type 5 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #6 (type 6, layer 0)
>  Making operation type 6 opaque [module /[Default VFS]/]
>  Accepting operation type 6 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #7 (type 7, layer 0)
>  Making operation type 7 opaque [module /[Default VFS]/]
>  Accepting operation type 7 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #8 (type 8, layer 0)
>  Making operation type 8 opaque [module /[Default VFS]/]
>  Accepting operation type 8 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #9 (type 9, layer 0)
>  Making operation type 9 opaque [module /[Default VFS]/]
>  Accepting operation type 9 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #10 (type 10, layer 0)
>  Making operation type 10 opaque [module /[Default VFS]/]
>  Accepting operation type 10 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #11 (type 11, layer 0)
>  Making operation type 11 opaque [module /[Default VFS]/]
>  Accepting operation type 11 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #12 (type 12, layer 0)
>  Making operation type 12 opaque [module /[Default VFS]/]
>  Accepting operation type 12 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #13 (type 13, layer 0)
>  Making operation type 13 opaque [module /[Default VFS]/]
>  Accepting operation type 13 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #14 (type 14, layer 0)
>  Making operation type 14 opaque [module /[Default VFS]/]
>  Accepting operation type 14 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #15 (type 15, layer 0)
>  Making operation type 15 opaque [module /[Default VFS]/]
>  Accepting operation type 15 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #16 (type 16, layer 0)
>  Making operation type 16 opaque [module /[Default VFS]/]
>  Accepting operation type 16 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #17 (type 17, layer 0)
>  Making operation type 17 opaque [module /[Default VFS]/]
>  Accepting operation type 17 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #18 (type 18, layer 0)
>  Making operation type 18 opaque [module /[Default VFS]/]
>  Accepting operation type 18 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #19 (type 19, layer 0)
>  Making operation type 19 opaque [module /[Default VFS]/]
>  Accepting operation type 19 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #20 (type 20, layer 0)
>  Making operation type 20 opaque [module /[Default VFS]/]
>  Accepting operation type 20 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #21 (type 21, layer 0)
>  Making operation type 21 opaque [module /[Default VFS]/]
>  Accepting operation type 21 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #22 (type 22, layer 0)
>  Making operation type 22 opaque [module /[Default VFS]/]
>  Accepting operation type 22 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #23 (type 23, layer 0)
>  Making operation type 23 opaque [module /[Default VFS]/]
>  Accepting operation type 23 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #24 (type 24, layer 0)
>  Making operation type 24 opaque [module /[Default VFS]/]
>  Accepting operation type 24 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #25 (type 25, layer 0)
>  Making operation type 25 opaque [module /[Default VFS]/]
>  Accepting operation type 25 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #26 (type 26, layer 0)
>  Making operation type 26 opaque [module /[Default VFS]/]
>  Accepting operation type 26 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #27 (type 27, layer 0)
>  Making operation type 27 opaque [module /[Default VFS]/]
>  Accepting operation type 27 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #28 (type 28, layer 0)
>  Making operation type 28 opaque [module /[Default VFS]/]
>  Accepting operation type 28 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #29 (type 29, layer 0)
>  Making operation type 29 opaque [module /[Default VFS]/]
>  Accepting operation type 29 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #30 (type 30, layer 0)
>  Making operation type 30 opaque [module /[Default VFS]/]
>  Accepting operation type 30 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #31 (type 31, layer 0)
>  Making operation type 31 opaque [module /[Default VFS]/]
>  Accepting operation type 31 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #32 (type 32, layer 0)
>  Making operation type 32 opaque [module /[Default VFS]/]
>  Accepting operation type 32 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #33 (type 33, layer 0)
>  Making operation type 33 opaque [module /[Default VFS]/]
>  Accepting operation type 33 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #34 (type 34, layer 0)
>  Making operation type 34 opaque [module /[Default VFS]/]
>  Accepting operation type 34 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #35 (type 35, layer 0)
>  Making operation type 35 opaque [module /[Default VFS]/]
>  Accepting operation type 35 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #36 (type 36, layer 0)
>  Making operation type 36 opaque [module /[Default VFS]/]
>  Accepting operation type 36 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #37 (type 37, layer 0)
>  Making operation type 37 opaque [module /[Default VFS]/]
>  Accepting operation type 37 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #38 (type 38, layer 0)
>  Making operation type 38 opaque [module /[Default VFS]/]
>  Accepting operation type 38 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #39 (type 39, layer 0)
>  Making operation type 39 opaque [module /[Default VFS]/]
>  Accepting operation type 39 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #40 (type 40, layer 0)
>  Making operation type 40 opaque [module /[Default VFS]/]
>  Accepting operation type 40 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #41 (type 41, layer 0)
>  Making operation type 41 opaque [module /[Default VFS]/]
>  Accepting operation type 41 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #42 (type 42, layer 0)
>  Making operation type 42 opaque [module /[Default VFS]/]
>  Accepting operation type 42 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #43 (type 43, layer 0)
>  Making operation type 43 opaque [module /[Default VFS]/]
>  Accepting operation type 43 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #44 (type 44, layer 0)
>  Making operation type 44 opaque [module /[Default VFS]/]
>  Accepting operation type 44 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #45 (type 45, layer 0)
>  Making operation type 45 opaque [module /[Default VFS]/]
>  Accepting operation type 45 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #46 (type 46, layer 0)
>  Making operation type 46 opaque [module /[Default VFS]/]
>  Accepting operation type 46 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #47 (type 47, layer 0)
>  Making operation type 47 opaque [module /[Default VFS]/]
>  Accepting operation type 47 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #48 (type 48, layer 0)
>  Making operation type 48 opaque [module /[Default VFS]/]
>  Accepting operation type 48 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #49 (type 49, layer 0)
>  Making operation type 49 opaque [module /[Default VFS]/]
>  Accepting operation type 49 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #50 (type 50, layer 0)
>  Making operation type 50 opaque [module /[Default VFS]/]
>  Accepting operation type 50 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #51 (type 51, layer 0)
>  Making operation type 51 opaque [module /[Default VFS]/]
>  Accepting operation type 51 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #52 (type 52, layer 0)
>  Making operation type 52 opaque [module /[Default VFS]/]
>  Accepting operation type 52 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #53 (type 53, layer 0)
>  Making operation type 53 opaque [module /[Default VFS]/]
>  Accepting operation type 53 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #54 (type 54, layer 0)
>  Making operation type 54 opaque [module /[Default VFS]/]
>  Accepting operation type 54 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #55 (type 55, layer 0)
>  Making operation type 55 opaque [module /[Default VFS]/]
>  Accepting operation type 55 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #56 (type 56, layer 0)
>  Making operation type 56 opaque [module /[Default VFS]/]
>  Accepting operation type 56 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #57 (type 57, layer 0)
>  Making operation type 57 opaque [module /[Default VFS]/]
>  Accepting operation type 57 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #58 (type 58, layer 0)
>  Making operation type 58 opaque [module /[Default VFS]/]
>  Accepting operation type 58 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #59 (type 59, layer 0)
>  Making operation type 59 opaque [module /[Default VFS]/]
>  Accepting operation type 59 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #60 (type 60, layer 0)
>  Making operation type 60 opaque [module /[Default VFS]/]
>  Accepting operation type 60 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #61 (type 61, layer 0)
>  Making operation type 61 opaque [module /[Default VFS]/]
>  Accepting operation type 61 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #62 (type 62, layer 0)
>  Making operation type 62 opaque [module /[Default VFS]/]
>  Accepting operation type 62 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #63 (type 63, layer 0)
>  Making operation type 63 opaque [module /[Default VFS]/]
>  Accepting operation type 63 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #64 (type 64, layer 0)
>  Making operation type 64 opaque [module /[Default VFS]/]
>  Accepting operation type 64 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #65 (type 65, layer 0)
>  Making operation type 65 opaque [module /[Default VFS]/]
>  Accepting operation type 65 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #66 (type 66, layer 0)
>  Making operation type 66 opaque [module /[Default VFS]/]
>  Accepting operation type 66 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #67 (type 67, layer 0)
>  Making operation type 67 opaque [module /[Default VFS]/]
>  Accepting operation type 67 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #68 (type 68, layer 0)
>  Making operation type 68 opaque [module /[Default VFS]/]
>  Accepting operation type 68 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #69 (type 69, layer 0)
>  Making operation type 69 opaque [module /[Default VFS]/]
>  Accepting operation type 69 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #70 (type 70, layer 0)
>  Making operation type 70 opaque [module /[Default VFS]/]
>  Accepting operation type 70 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #71 (type 71, layer 0)
>  Making operation type 71 opaque [module /[Default VFS]/]
>  Accepting operation type 71 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #72 (type 72, layer 0)
>  Making operation type 72 opaque [module /[Default VFS]/]
>  Accepting operation type 72 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #73 (type 73, layer 0)
>  Making operation type 73 opaque [module /[Default VFS]/]
>  Accepting operation type 73 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #74 (type 74, layer 0)
>  Making operation type 74 opaque [module /[Default VFS]/]
>  Accepting operation type 74 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #75 (type 75, layer 0)
>  Making operation type 75 opaque [module /[Default VFS]/]
>  Accepting operation type 75 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #76 (type 76, layer 0)
>  Making operation type 76 opaque [module /[Default VFS]/]
>  Accepting operation type 76 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #77 (type 77, layer 0)
>  Making operation type 77 opaque [module /[Default VFS]/]
>  Accepting operation type 77 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #78 (type 78, layer 0)
>  Making operation type 78 opaque [module /[Default VFS]/]
>  Accepting operation type 78 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #79 (type 79, layer 0)
>  Making operation type 79 opaque [module /[Default VFS]/]
>  Accepting operation type 79 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #80 (type 80, layer 0)
>  Making operation type 80 opaque [module /[Default VFS]/]
>  Accepting operation type 80 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #81 (type 81, layer 0)
>  Making operation type 81 opaque [module /[Default VFS]/]
>  Accepting operation type 81 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #82 (type 82, layer 0)
>  Making operation type 82 opaque [module /[Default VFS]/]
>  Accepting operation type 82 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #83 (type 83, layer 0)
>  Making operation type 83 opaque [module /[Default VFS]/]
>  Accepting operation type 83 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #84 (type 84, layer 0)
>  Making operation type 84 opaque [module /[Default VFS]/]
>  Accepting operation type 84 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #85 (type 85, layer 0)
>  Making operation type 85 opaque [module /[Default VFS]/]
>  Accepting operation type 85 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #86 (type 86, layer 0)
>  Making operation type 86 opaque [module /[Default VFS]/]
>  Accepting operation type 86 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #87 (type 87, layer 0)
>  Making operation type 87 opaque [module /[Default VFS]/]
>  Accepting operation type 87 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #88 (type 88, layer 0)
>  Making operation type 88 opaque [module /[Default VFS]/]
>  Accepting operation type 88 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #89 (type 89, layer 0)
>  Making operation type 89 opaque [module /[Default VFS]/]
>  Accepting operation type 89 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #90 (type 90, layer 0)
>  Making operation type 90 opaque [module /[Default VFS]/]
>  Accepting operation type 90 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #91 (type 91, layer 0)
>  Making operation type 91 opaque [module /[Default VFS]/]
>  Accepting operation type 91 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #92 (type 92, layer 0)
>  Making operation type 92 opaque [module /[Default VFS]/]
>  Accepting operation type 92 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #93 (type 93, layer 0)
>  Making operation type 93 opaque [module /[Default VFS]/]
>  Accepting operation type 93 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #94 (type 94, layer 0)
>  Making operation type 94 opaque [module /[Default VFS]/]
>  Accepting operation type 94 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #95 (type 95, layer 0)
>  Making operation type 95 opaque [module /[Default VFS]/]
>  Accepting operation type 95 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #96 (type 96, layer 0)
>  Making operation type 96 opaque [module /[Default VFS]/]
>  Accepting operation type 96 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #97 (type 97, layer 0)
>  Making operation type 97 opaque [module /[Default VFS]/]
>  Accepting operation type 97 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #98 (type 98, layer 0)
>  Making operation type 98 opaque [module /[Default VFS]/]
>  Accepting operation type 98 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #99 (type 99, layer 0)
>  Making operation type 99 opaque [module /[Default VFS]/]
>  Accepting operation type 99 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #100 (type 100, layer 0)
>  Making operation type 100 opaque [module /[Default VFS]/]
>  Accepting operation type 100 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #101 (type 101, layer 0)
>  Making operation type 101 opaque [module /[Default VFS]/]
>  Accepting operation type 101 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #102 (type 102, layer 0)
>  Making operation type 102 opaque [module /[Default VFS]/]
>  Accepting operation type 102 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #103 (type 103, layer 0)
>  Making operation type 103 opaque [module /[Default VFS]/]
>  Accepting operation type 103 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #104 (type 104, layer 0)
>  Making operation type 104 opaque [module /[Default VFS]/]
>  Accepting operation type 104 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #105 (type 105, layer 0)
>  Making operation type 105 opaque [module /[Default VFS]/]
>  Accepting operation type 105 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #106 (type 106, layer 0)
>  Making operation type 106 opaque [module /[Default VFS]/]
>  Accepting operation type 106 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #107 (type 107, layer 0)
>  Making operation type 107 opaque [module /[Default VFS]/]
>  Accepting operation type 107 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #108 (type 108, layer 0)
>  Making operation type 108 opaque [module /[Default VFS]/]
>  Accepting operation type 108 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #109 (type 109, layer 0)
>  Making operation type 109 opaque [module /[Default VFS]/]
>  Accepting operation type 109 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/vfs.c:192(vfs_init_custom)
>  Checking operation #110 (type 110, layer 0)
>  Making operation type 110 opaque [module /[Default VFS]/]
>  Accepting operation type 110 from module /[Default VFS]/
>[2009/09/24 09:06:23,  5] smbd/connection.c:142(claim_connection)
>  claiming [IPC$]
>[2009/09/24 09:06:23, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
>  Locking key FC780000010000004950
>[2009/09/24 09:06:23, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
>  Allocated locked data 0x0x807566d0
>[2009/09/24 09:06:23, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
>  Unlocking key FC780000010000004950
>[2009/09/24 09:06:23, 10] smbd/share_access.c:234(user_ok_token)
>  user_ok_token: share IPC$ is ok for unix user nobody
>[2009/09/24 09:06:23, 10] smbd/share_access.c:279(is_share_read_only_for_token)
>  is_share_read_only_for_user: share IPC$ is read-only for unix user nobody
>[2009/09/24 09:06:23, 10] lib/util_seaccess.c:58(se_map_generic)
>  se_map_generic(): mapped mask 0x10000000 to 0x001f01ff
>[2009/09/24 09:06:23,  3] lib/util_sid.c:228(string_to_sid)
>  string_to_sid: Sid MUC\Administrator does not start with 'S-'.
>[2009/09/24 09:06:23, 10] passdb/lookup_sid.c:69(lookup_name)
>  lookup_name: MUC\Administrator => MUC (domain), Administrator (name)
>[2009/09/24 09:06:23, 10] passdb/lookup_sid.c:70(lookup_name)
>  lookup_name: flags = 0x073
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:572(pdb_set_username)
>  pdb_set_username: setting username nobody, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:595(pdb_set_domain)
>  pdb_set_domain: setting domain NUCLEUS, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:618(pdb_set_nt_username)
>  pdb_set_nt_username: setting nt username , was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:641(pdb_set_fullname)
>  pdb_set_full_name: setting full name nobody, was 
>[2009/09/24 09:06:23,  4] lib/substitute.c:504(automount_server)
>  Home server: nucleus
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:734(pdb_set_homedir)
>  pdb_set_homedir: setting home dir \\nucleus\nobody, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:710(pdb_set_dir_drive)
>  pdb_set_dir_drive: setting dir drive , was NULL
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:664(pdb_set_logon_script)
>  pdb_set_logon_script: setting logon script , was 
>[2009/09/24 09:06:23,  4] lib/substitute.c:504(automount_server)
>  Home server: nucleus
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:687(pdb_set_profile_path)
>  pdb_set_profile_path: setting profile path \\nucleus\nobody\profile, was 
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:777(pdb_set_workstations)
>  pdb_set_workstations: setting workstations , was 
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23, 10] lib/account_pol.c:333(account_policy_get)
>  account_policy_get: name: password history, val: 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23, 10] passdb/pdb_get_set.c:501(pdb_set_user_sid)
>  pdb_set_user_sid: setting user sid S-1-5-21-3081873947-908747446-877470218-501
>[2009/09/24 09:06:23, 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-3081873947-908747446-877470218-501 from rid 501
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (65534, 65533) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  5] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-3081873947-908747446-877470218-501
>  contains 8 SIDs
>  SID[  0]: S-1-5-21-3081873947-908747446-877470218-501
>  SID[  1]: S-1-1-0
>  SID[  2]: S-1-5-2
>  SID[  3]: S-1-5-32-546
>  SID[  4]: S-1-22-1-65534
>  SID[  5]: S-1-22-2-30061
>  SID[  6]: S-1-22-2-30036
>  SID[  7]: S-1-22-2-30086
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2009/09/24 09:06:23,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 65534
>  Primary group is 65533 and contains 3 supplementary groups
>  Group[  0]: 30061
>  Group[  1]: 30036
>  Group[  2]: 30086
>[2009/09/24 09:06:23,  5] smbd/uid.c:353(change_to_user)
>  change_to_user uid=(0,65534) gid=(0,65533)
>[2009/09/24 09:06:23,  3] smbd/service.c:1043(make_connection_snum)
>  it-01 (10.1.0.254) connect to service IPC$ initially as user nobody (uid=65534, gid=65533) (pid 30972)
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:23,  3] smbd/reply.c:754(reply_tcon_and_X)
>  tconX service=IPC$ 
>[2009/09/24 09:06:23, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 106
>[2009/09/24 09:06:23,  6] smbd/process.c:1436(process_smb)
>  got message type 0x0 of len 0x6a
>[2009/09/24 09:06:23,  3] smbd/process.c:1439(process_smb)
>  Transaction 4 of length 110 (0 toread)
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=106
>  smb_com=0x32
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=4
>  smb_uid=100
>  smb_mid=256
>  smt_wct=15
>  smb_vwv[ 0]=   38 (0x26)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]= 4096 (0x1000)
>  smb_vwv[ 4]=    0 (0x0)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=    0 (0x0)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=   38 (0x26)
>  smb_vwv[10]=   68 (0x44)
>  smb_vwv[11]=    0 (0x0)
>  smb_vwv[12]=    0 (0x0)
>  smb_vwv[13]=    1 (0x1)
>  smb_vwv[14]=   16 (0x10)
>  smb_bcc=41
>[2009/09/24 09:06:23, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 00 00 00 04 00 5C 00 6E   00 75 00 63 00 6C 00 65   .....\.n .u.c.l.e
>  [0010] 00 75 00 73 00 5C 00 70   00 61 00 63 00 6B 00 61   .u.s.\.p .a.c.k.a
>  [0020] 00 67 00 65 00 73 00 00   00                       .g.e.s.. .
>[2009/09/24 09:06:23,  3] smbd/process.c:1252(switch_message)
>  switch message SMBtrans2 (pid 30972) conn 0x8074ff28
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (65534, 65533) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  5] auth/token_util.c:528(debug_nt_user_token)
>  NT user token of user S-1-5-21-3081873947-908747446-877470218-501
>  contains 8 SIDs
>  SID[  0]: S-1-5-21-3081873947-908747446-877470218-501
>  SID[  1]: S-1-1-0
>  SID[  2]: S-1-5-2
>  SID[  3]: S-1-5-32-546
>  SID[  4]: S-1-22-1-65534
>  SID[  5]: S-1-22-2-30061
>  SID[  6]: S-1-22-2-30036
>  SID[  7]: S-1-22-2-30086
>  SE_PRIV  0x0 0x0 0x0 0x0
>[2009/09/24 09:06:23,  5] auth/token_util.c:548(debug_unix_user_token)
>  UNIX token of user 65534
>  Primary group is 65533 and contains 3 supplementary groups
>  Group[  0]: 30061
>  Group[  1]: 30036
>  Group[  2]: 30086
>[2009/09/24 09:06:23,  5] smbd/uid.c:353(change_to_user)
>  change_to_user uid=(0,65534) gid=(0,65533)
>[2009/09/24 09:06:23,  4] smbd/vfs.c:753(vfs_ChDir)
>  vfs_ChDir to /tmp
>[2009/09/24 09:06:23, 10] smbd/trans2.c:7387(call_trans2getdfsreferral)
>  call_trans2getdfsreferral
>[2009/09/24 09:06:23, 10] smbd/msdfs.c:107(parse_dfs_path)
>  parse_dfs_path: temp = |nucleus\packages| after trimming \'s
>[2009/09/24 09:06:23, 10] smbd/msdfs.c:132(parse_dfs_path)
>  parse_dfs_path: hostname: nucleus
>[2009/09/24 09:06:23, 10] smbd/msdfs.c:174(parse_dfs_path)
>  parse_dfs_path: servicename: packages
>[2009/09/24 09:06:23,  3] smbd/msdfs.c:828(get_referred_path)
>  get_referred_path: |packages| in dfs path \nucleus\packages is not a dfs root.
>[2009/09/24 09:06:23,  3] smbd/error.c:60(error_packet_set)
>  error packet at smbd/trans2.c(7409) cmd=50 (SMBtrans2) NT_STATUS_NOT_FOUND
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=35
>  smb_com=0x32
>  smb_rcls=37
>  smb_reh=2
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=1
>  smb_pid=4
>  smb_uid=100
>  smb_mid=256
>  smt_wct=0
>  smb_bcc=0
>[2009/09/24 09:06:23, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 236
>[2009/09/24 09:06:23,  6] smbd/process.c:1436(process_smb)
>  got message type 0x0 of len 0xec
>[2009/09/24 09:06:23,  3] smbd/process.c:1439(process_smb)
>  Transaction 5 of length 240 (0 toread)
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=236
>  smb_com=0x73
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=0
>  smb_mid=320
>  smt_wct=12
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=  236 (0xEC)
>  smb_vwv[ 2]=16644 (0x4104)
>  smb_vwv[ 3]=   50 (0x32)
>  smb_vwv[ 4]=    1 (0x1)
>  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=177
>[2009/09/24 09:06:23, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] 60 48 06 06 2B 06 01 05   05 02 A0 3E 30 3C A0 0E   `H..+... ...>0<..
>  [0010] 30 0C 06 0A 2B 06 01 04   01 82 37 02 02 0A A2 2A   0...+... ..7....*
>  [0020] 04 28 4E 54 4C 4D 53 53   50 00 01 00 00 00 07 82   .(NTLMSS P.......
>  [0030] 08 A2 00 00 00 00 00 00   00 00 00 00 00 00 00 00   ........ ........
>  [0040] 00 00 05 01 28 0A 00 00   00 0F 00 57 00 69 00 6E   ....(... ...W.i.n
>  [0050] 00 64 00 6F 00 77 00 73   00 20 00 32 00 30 00 30   .d.o.w.s . .2.0.0
>  [0060] 00 32 00 20 00 53 00 65   00 72 00 76 00 69 00 63   .2. .S.e .r.v.i.c
>  [0070] 00 65 00 20 00 50 00 61   00 63 00 6B 00 20 00 33   .e. .P.a .c.k. .3
>  [0080] 00 20 00 32 00 36 00 30   00 30 00 00 00 57 00 69   . .2.6.0 .0...W.i
>  [0090] 00 6E 00 64 00 6F 00 77   00 73 00 20 00 32 00 30   .n.d.o.w .s. .2.0
>  [00A0] 00 30 00 32 00 20 00 35   00 2E 00 31 00 00 00 00   .0.2. .5 ...1....
>  [00B0] 00                                                . 
>[2009/09/24 09:06:23,  3] smbd/process.c:1252(switch_message)
>  switch message SMBsesssetupX (pid 30972) conn 0x0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:23,  3] smbd/sesssetup.c:1404(reply_sesssetup_and_X)
>  wct=12 flg2=0xc807
>[2009/09/24 09:06:23,  3] smbd/sesssetup.c:1160(reply_sesssetup_and_X_spnego)
>  Doing spnego session setup
>[2009/09/24 09:06:23,  3] smbd/sesssetup.c:1202(reply_sesssetup_and_X_spnego)
>  NativeOS=[Windows 2002 Service Pack 3 2600] NativeLanMan=[Windows 2002 5.1] PrimaryDomain=[]
>[2009/09/24 09:06:23, 10] smbd/password.c:172(register_initial_vuid)
>  register_initial_vuid: allocated vuid = 101
>[2009/09/24 09:06:23, 10] smbd/sesssetup.c:1106(check_spnego_blob_complete)
>  check_spnego_blob_complete: needed_len = 74, pblob->length = 74
>[2009/09/24 09:06:23,  5] smbd/sesssetup.c:735(parse_spnego_mechanisms)
>  parse_spnego_mechanisms: Got OID 1.3.6.1.4.1.311.2.2.10
>[2009/09/24 09:06:23,  3] smbd/sesssetup.c:786(reply_spnego_negotiate)
>  reply_spnego_negotiate: Got secblob of size 40
>[2009/09/24 09:06:23,  5] auth/auth.c:473(make_auth_context_subsystem)
>  Making default auth method list for security=domain
>[2009/09/24 09:06:23,  5] auth/auth.c:389(load_auth_module)
>  load_auth_module: Attempting to find an auth method to match guest
>[2009/09/24 09:06:23,  5] auth/auth.c:414(load_auth_module)
>  load_auth_module: auth method guest has a valid init
>[2009/09/24 09:06:23,  5] auth/auth.c:389(load_auth_module)
>  load_auth_module: Attempting to find an auth method to match sam
>[2009/09/24 09:06:23,  5] auth/auth.c:414(load_auth_module)
>  load_auth_module: auth method sam has a valid init
>[2009/09/24 09:06:23,  5] auth/auth.c:389(load_auth_module)
>  load_auth_module: Attempting to find an auth method to match winbind:ntdomain
>[2009/09/24 09:06:23,  5] auth/auth.c:389(load_auth_module)
>  load_auth_module: Attempting to find an auth method to match ntdomain
>[2009/09/24 09:06:23,  5] auth/auth.c:414(load_auth_module)
>  load_auth_module: auth method ntdomain has a valid init
>[2009/09/24 09:06:23,  5] auth/auth.c:414(load_auth_module)
>  load_auth_module: auth method winbind has a valid init
>[2009/09/24 09:06:23,  3] libsmb/ntlmssp.c:62(debug_ntlmssp_flags)
>  Got NTLMSSP neg_flags=0xa2088207
>    NTLMSSP_NEGOTIATE_UNICODE
>    NTLMSSP_NEGOTIATE_OEM
>    NTLMSSP_REQUEST_TARGET
>    NTLMSSP_NEGOTIATE_NTLM
>    NTLMSSP_NEGOTIATE_ALWAYS_SIGN
>    NTLMSSP_NEGOTIATE_NTLM2
>    NTLMSSP_NEGOTIATE_VERSION
>    NTLMSSP_NEGOTIATE_128
>    NTLMSSP_NEGOTIATE_56
>[2009/09/24 09:06:23,  5] auth/auth.c:98(get_ntlm_challenge)
>  auth_get_challenge: module guest did not want to specify a challenge
>[2009/09/24 09:06:23,  5] auth/auth.c:98(get_ntlm_challenge)
>  auth_get_challenge: module sam did not want to specify a challenge
>[2009/09/24 09:06:23,  5] auth/auth.c:98(get_ntlm_challenge)
>  auth_get_challenge: module winbind did not want to specify a challenge
>[2009/09/24 09:06:23,  5] auth/auth.c:138(get_ntlm_challenge)
>  auth_context challenge created by random
>[2009/09/24 09:06:23,  5] auth/auth.c:139(get_ntlm_challenge)
>  challenge is: 
>[2009/09/24 09:06:23,  5] ../lib/util/util.c:304(_dump_data)
>  [0000] 0E 34 7D 15 6E C4 D7 94                            .4}.n... 
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=266
>  smb_com=0x73
>  smb_rcls=22
>  smb_reh=0
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=101
>  smb_mid=320
>  smt_wct=4
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_vwv[ 2]=    0 (0x0)
>  smb_vwv[ 3]=  181 (0xB5)
>  smb_bcc=223
>[2009/09/24 09:06:23, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] A1 81 B2 30 81 AF A0 03   0A 01 01 A1 0C 06 0A 2B   ...0.... .......+
>  [0010] 06 01 04 01 82 37 02 02   0A A2 81 99 04 81 96 4E   .....7.. .......N
>  [0020] 54 4C 4D 53 53 50 00 02   00 00 00 06 00 06 00 30   TLMSSP.. .......0
>  [0030] 00 00 00 05 82 89 A2 0E   34 7D 15 6E C4 D7 94 00   ........ 4}.n....
>  [0040] 00 00 00 00 00 00 00 60   00 60 00 36 00 00 00 4D   .......` .`.6...M
>  [0050] 00 55 00 43 00 02 00 06   00 4D 00 55 00 43 00 01   .U.C.... .M.U.C..
>  [0060] 00 0E 00 4E 00 55 00 43   00 4C 00 45 00 55 00 53   ...N.U.C .L.E.U.S
>  [0070] 00 04 00 14 00 6D 00 72   00 2E 00 6C 00 66 00 6D   .....m.r ...l.f.m
>  [0080] 00 67 00 2E 00 64 00 65   00 03 00 24 00 6E 00 75   .g...d.e ...$.n.u
>  [0090] 00 63 00 6C 00 65 00 75   00 73 00 2E 00 6D 00 72   .c.l.e.u .s...m.r
>  [00A0] 00 2E 00 6C 00 66 00 6D   00 67 00 2E 00 64 00 65   ...l.f.m .g...d.e
>  [00B0] 00 00 00 00 00 55 00 6E   00 69 00 78 00 00 00 53   .....U.n .i.x...S
>  [00C0] 00 61 00 6D 00 62 00 61   00 20 00 33 00 2E 00 34   .a.m.b.a . .3...4
>  [00D0] 00 2E 00 31 00 00 00 4D   00 55 00 43 00 00 00     ...1...M .U.C...
>[2009/09/24 09:06:23, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 328
>[2009/09/24 09:06:23,  6] smbd/process.c:1436(process_smb)
>  got message type 0x0 of len 0x148
>[2009/09/24 09:06:23,  3] smbd/process.c:1439(process_smb)
>  Transaction 6 of length 332 (0 toread)
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=328
>  smb_com=0x73
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=101
>  smb_mid=384
>  smt_wct=12
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=  328 (0x148)
>  smb_vwv[ 2]=16644 (0x4104)
>  smb_vwv[ 3]=   50 (0x32)
>  smb_vwv[ 4]=    1 (0x1)
>  smb_vwv[ 5]=    0 (0x0)
>  smb_vwv[ 6]=    0 (0x0)
>  smb_vwv[ 7]=  166 (0xA6)
>  smb_vwv[ 8]=    0 (0x0)
>  smb_vwv[ 9]=    0 (0x0)
>  smb_vwv[10]=  212 (0xD4)
>  smb_vwv[11]=40960 (0xA000)
>  smb_bcc=269
>[2009/09/24 09:06:23, 10] ../lib/util/util.c:304(_dump_data)
>  [0000] A1 81 A3 30 81 A0 A2 81   9D 04 81 9A 4E 54 4C 4D   ...0.... ....NTLM
>  [0010] 53 53 50 00 03 00 00 00   18 00 18 00 6A 00 00 00   SSP..... ....j...
>  [0020] 18 00 18 00 82 00 00 00   06 00 06 00 48 00 00 00   ........ ....H...
>  [0030] 12 00 12 00 4E 00 00 00   0A 00 0A 00 60 00 00 00   ....N... ....`...
>  [0040] 00 00 00 00 9A 00 00 00   05 82 88 A2 05 01 28 0A   ........ ......(.
>  [0050] 00 00 00 0F 4D 00 55 00   43 00 6D 00 75 00 65 00   ....M.U. C.m.u.e.
>  [0060] 68 00 6C 00 66 00 65 00   6C 00 64 00 49 00 54 00   h.l.f.e. l.d.I.T.
>  [0070] 2D 00 30 00 31 00 25 F9   6D 95 AB 99 35 3B 00 00   -.0.1.%. m...5;..
>  [0080] 00 00 00 00 00 00 00 00   00 00 00 00 00 00 65 1F   ........ ......e.
>  [0090] 20 54 88 32 10 DC 69 A1   BC 15 07 20 5F A8 7A 70    T.2..i. ... _.zp
>  [00A0] 63 AF C8 A1 D4 60 00 57   00 69 00 6E 00 64 00 6F   c....`.W .i.n.d.o
>  [00B0] 00 77 00 73 00 20 00 32   00 30 00 30 00 32 00 20   .w.s. .2 .0.0.2. 
>  [00C0] 00 53 00 65 00 72 00 76   00 69 00 63 00 65 00 20   .S.e.r.v .i.c.e. 
>  [00D0] 00 50 00 61 00 63 00 6B   00 20 00 33 00 20 00 32   .P.a.c.k . .3. .2
>  [00E0] 00 36 00 30 00 30 00 00   00 57 00 69 00 6E 00 64   .6.0.0.. .W.i.n.d
>  [00F0] 00 6F 00 77 00 73 00 20   00 32 00 30 00 30 00 32   .o.w.s.  .2.0.0.2
>  [0100] 00 20 00 35 00 2E 00 31   00 00 00 00 00           . .5...1 .....
>[2009/09/24 09:06:23,  3] smbd/process.c:1252(switch_message)
>  switch message SMBsesssetupX (pid 30972) conn 0x0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:23,  3] smbd/sesssetup.c:1404(reply_sesssetup_and_X)
>  wct=12 flg2=0xc807
>[2009/09/24 09:06:23,  3] smbd/sesssetup.c:1160(reply_sesssetup_and_X_spnego)
>  Doing spnego session setup
>[2009/09/24 09:06:23,  3] smbd/sesssetup.c:1202(reply_sesssetup_and_X_spnego)
>  NativeOS=[Windows 2002 Service Pack 3 2600] NativeLanMan=[Windows 2002 5.1] PrimaryDomain=[]
>[2009/09/24 09:06:23, 10] smbd/sesssetup.c:1106(check_spnego_blob_complete)
>  check_spnego_blob_complete: needed_len = 166, pblob->length = 166
>[2009/09/24 09:06:23,  3] libsmb/ntlmssp.c:745(ntlmssp_server_auth)
>  Got user=[muehlfeld] domain=[MUC] workstation=[IT-01] len1=24 len2=24
>[2009/09/24 09:06:23,  5] auth/auth_ntlmssp.c:70(auth_ntlmssp_set_challenge)
>  auth_context challenge set by NTLMSSP callback (NTLM2)
>[2009/09/24 09:06:23,  5] auth/auth_ntlmssp.c:71(auth_ntlmssp_set_challenge)
>  challenge is: 
>[2009/09/24 09:06:23,  5] ../lib/util/util.c:304(_dump_data)
>  [0000] 10 BC C4 28 D5 19 E8 D8                            ...(.... 
>[2009/09/24 09:06:23,  6] param/loadparm.c:6989(lp_file_list_changed)
>  lp_file_list_changed()
>  file /etc/samba/shares.conf -> /etc/samba/shares.conf  last mod_time: Wed Jul 15 16:15:19 2009
>  
>  file /etc/samba//smb.conf -> /etc/samba//smb.conf  last mod_time: Thu Sep 24 09:05:40 2009
>  
>[2009/09/24 09:06:23,  5] auth/auth_util.c:208(make_user_info_map)
>  Mapping user [MUC]\[muehlfeld] from workstation [IT-01]
>[2009/09/24 09:06:23,  5] auth/auth_util.c:120(make_user_info)
>  attempting to make a user_info for muehlfeld (muehlfeld)
>[2009/09/24 09:06:23,  5] auth/auth_util.c:130(make_user_info)
>  making strings for muehlfeld's user_info struct
>[2009/09/24 09:06:23,  5] auth/auth_util.c:162(make_user_info)
>  making blobs for muehlfeld's user_info struct
>[2009/09/24 09:06:23, 10] auth/auth_util.c:180(make_user_info)
>  made an encrypted user_info for muehlfeld (muehlfeld)
>[2009/09/24 09:06:23,  3] auth/auth.c:222(check_ntlm_password)
>  check_ntlm_password:  Checking password for unmapped user [MUC]\[muehlfeld]@[IT-01] with the new password interface
>[2009/09/24 09:06:23,  3] auth/auth.c:225(check_ntlm_password)
>  check_ntlm_password:  mapped user is: [MUC]\[muehlfeld]@[IT-01]
>[2009/09/24 09:06:23, 10] auth/auth.c:234(check_ntlm_password)
>  check_ntlm_password: auth_context challenge created by NTLMSSP callback (NTLM2)
>[2009/09/24 09:06:23, 10] auth/auth.c:236(check_ntlm_password)
>  challenge is: 
>[2009/09/24 09:06:23,  5] ../lib/util/util.c:304(_dump_data)
>  [0000] 10 BC C4 28 D5 19 E8 D8                            ...(.... 
>[2009/09/24 09:06:23, 10] auth/auth.c:262(check_ntlm_password)
>  check_ntlm_password: guest had nothing to say
>[2009/09/24 09:06:23,  8] lib/util.c:1879(is_myname)
>  is_myname("MUC") returns 0
>[2009/09/24 09:06:23,  6] auth/auth_sam.c:416(check_samstrict_security)
>  check_samstrict_security: MUC is not one of my local names (ROLE_DOMAIN_MEMBER)
>[2009/09/24 09:06:23, 10] auth/auth.c:262(check_ntlm_password)
>  check_ntlm_password: sam had nothing to say
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:210(push_sec_ctx)
>  push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  3] smbd/uid.c:428(push_conn_ctx)
>  push_conn_ctx(0) : conn_ctx_stack_ndx = 0
>[2009/09/24 09:06:23,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1
>[2009/09/24 09:06:23,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:23,  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/24 09:06:23,  3] smbd/sec_ctx.c:418(pop_sec_ctx)
>  pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:23, 10] auth/auth_winbind.c:85(check_winbind_security)
>  check_winbind_security: wbcAuthenticateUserEx failed: WBC_ERR_AUTH_ERROR
>[2009/09/24 09:06:23,  5] auth/auth.c:274(check_ntlm_password)
>  check_ntlm_password: winbind authentication for user [muehlfeld] FAILED with error NT_STATUS_ACCESS_DENIED
>[2009/09/24 09:06:23,  2] auth/auth.c:320(check_ntlm_password)
>  check_ntlm_password:  Authentication for user [muehlfeld] -> [muehlfeld] FAILED with error NT_STATUS_ACCESS_DENIED
>[2009/09/24 09:06:23,  5] auth/auth_util.c:2114(free_user_info)
>  attempting to free (and zero) a user_info structure
>[2009/09/24 09:06:23, 10] auth/auth_util.c:2118(free_user_info)
>  structure was created for muehlfeld
>[2009/09/24 09:06:23,  3] smbd/error.c:60(error_packet_set)
>  error packet at smbd/sesssetup.c(122) cmd=115 (SMBsesssetupX) NT_STATUS_ACCESS_DENIED
>[2009/09/24 09:06:23,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:23,  5] lib/util.c:642(show_msg)
>  size=35
>  smb_com=0x73
>  smb_rcls=34
>  smb_reh=0
>  smb_err=49152
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=101
>  smb_mid=384
>  smt_wct=0
>  smb_bcc=0
>[2009/09/24 09:06:33, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 39
>[2009/09/24 09:06:33,  6] smbd/process.c:1436(process_smb)
>  got message type 0x0 of len 0x27
>[2009/09/24 09:06:33,  3] smbd/process.c:1439(process_smb)
>  Transaction 7 of length 43 (0 toread)
>[2009/09/24 09:06:33,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:33,  5] lib/util.c:642(show_msg)
>  size=39
>  smb_com=0x74
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=0
>  smb_pid=65279
>  smb_uid=100
>  smb_mid=448
>  smt_wct=2
>  smb_vwv[ 0]=  255 (0xFF)
>  smb_vwv[ 1]=    0 (0x0)
>  smb_bcc=0
>[2009/09/24 09:06:33,  3] smbd/process.c:1252(switch_message)
>  switch message SMBulogoffX (pid 30972) conn 0x0
>[2009/09/24 09:06:33,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:33,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:33,  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/24 09:06:33,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:33,  3] smbd/reply.c:1925(reply_ulogoffX)
>  ulogoffX vuid=100
>[2009/09/24 09:06:33, 10] lib/util_sock.c:789(read_smb_length_return_keepalive)
>  got smb length of 35
>[2009/09/24 09:06:33,  6] smbd/process.c:1436(process_smb)
>  got message type 0x0 of len 0x23
>[2009/09/24 09:06:33,  3] smbd/process.c:1439(process_smb)
>  Transaction 8 of length 39 (0 toread)
>[2009/09/24 09:06:33,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:33,  5] lib/util.c:642(show_msg)
>  size=35
>  smb_com=0x71
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=24
>  smb_flg2=51207
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=100
>  smb_mid=512
>  smt_wct=0
>  smb_bcc=0
>[2009/09/24 09:06:33,  3] smbd/process.c:1252(switch_message)
>  switch message SMBtdis (pid 30972) conn 0x8074ff28
>[2009/09/24 09:06:33,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:33,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:33,  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/24 09:06:33,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:33,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:33,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:33,  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/24 09:06:33,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:33,  3] smbd/service.c:1222(close_cnum)
>  it-01 (10.1.0.254) closed connection to service IPC$
>[2009/09/24 09:06:33,  3] smbd/connection.c:31(yield_connection)
>  Yielding connection to IPC$
>[2009/09/24 09:06:33, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked)
>  Locking key FC780000010000004950
>[2009/09/24 09:06:33, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked)
>  Allocated locked data 0x0x8073efe8
>[2009/09/24 09:06:33, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr)
>  Unlocking key FC780000010000004950
>[2009/09/24 09:06:33,  4] smbd/vfs.c:753(vfs_ChDir)
>  vfs_ChDir to /
>[2009/09/24 09:06:33,  3] smbd/sec_ctx.c:310(set_sec_ctx)
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0
>[2009/09/24 09:06:33,  5] auth/token_util.c:522(debug_nt_user_token)
>  NT user token: (NULL)
>[2009/09/24 09:06:33,  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/24 09:06:33,  5] smbd/uid.c:368(change_to_root_user)
>  change_to_root_user: now uid=(0,0) gid=(0,0)
>[2009/09/24 09:06:33,  5] lib/util.c:632(show_msg)
>[2009/09/24 09:06:33,  5] lib/util.c:642(show_msg)
>  size=35
>  smb_com=0x71
>  smb_rcls=0
>  smb_reh=0
>  smb_err=0
>  smb_flg=136
>  smb_flg2=51201
>  smb_tid=1
>  smb_pid=65279
>  smb_uid=100
>  smb_mid=512
>  smt_wct=0
>  smb_bcc=0

Actions: View

Attachments on bug 6555: 4428 | 4429 | 4430 | 4446 | 4583 | 4584 | 4645 | 4646 | 4735 | 4736 | 4737 | 4773 | 4774