[2010/07/26 20:03:46.980822, 6] param/loadparm.c:7133(lp_file_list_changed) lp_file_list_changed() file /opt/samba/lib/smb.conf -> /opt/samba/lib/smb.conf last mod_time: Mon Jul 26 18:46:25 2010 [2010/07/26 20:03:46.980918, 5] auth/auth_util.c:211(make_user_info_map) Mapping user [PROSERVE]\[user1] from workstation [CEPURE] [2010/07/26 20:03:46.981892, 5] auth/auth_util.c:122(make_user_info) attempting to make a user_info for user1 (user1) [2010/07/26 20:03:46.981923, 5] auth/auth_util.c:132(make_user_info) making strings for user1's user_info struct [2010/07/26 20:03:46.981954, 5] auth/auth_util.c:164(make_user_info) making blobs for user1's user_info struct [2010/07/26 20:03:46.981980, 10] auth/auth_util.c:182(make_user_info) made an encrypted user_info for user1 (user1) [2010/07/26 20:03:46.982004, 3] auth/auth.c:216(check_ntlm_password) check_ntlm_password: Checking password for unmapped user [PROSERVE]\[user1]@[CEPURE] with the new password interface [2010/07/26 20:03:46.982030, 3] auth/auth.c:219(check_ntlm_password) check_ntlm_password: mapped user is: [PROSERVE]\[user1]@[CEPURE] [2010/07/26 20:03:46.982059, 10] auth/auth.c:228(check_ntlm_password) check_ntlm_password: auth_context challenge created by NTLMSSP callback (NTLM2) [2010/07/26 20:03:46.982083, 10] auth/auth.c:230(check_ntlm_password) challenge is: [2010/07/26 20:03:46.982107, 5] ../lib/util/util.c:278(_dump_data) [0000] A6 08 6D 3B 49 24 77 0C ..m;I$w. [2010/07/26 20:03:46.982141, 10] auth/auth.c:256(check_ntlm_password) check_ntlm_password: guest had nothing to say [2010/07/26 20:03:46.982171, 8] lib/util.c:1869(is_myname) is_myname("PROSERVE") returns 0 [2010/07/26 20:03:46.982196, 6] auth/auth_sam.c:556(check_samstrict_security) check_samstrict_security: PROSERVE is not one of my local names (ROLE_DOMAIN_MEMBER) [2010/07/26 20:03:46.982226, 10] auth/auth.c:256(check_ntlm_password) check_ntlm_password: sam had nothing to say [2010/07/26 20:03:46.982255, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:46.982296, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:46.982321, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:46.982345, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:46.982369, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:46.994497, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:46.994559, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user PROSERVE+user1 [2010/07/26 20:03:46.994586, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is proserve+user1 [2010/07/26 20:03:46.995822, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [PROSERVE+user1]! [2010/07/26 20:03:46.995863, 5] auth/auth_util.c:1522(fill_sam_account) fill_sam_account: located username was [PROSERVE+user1] [2010/07/26 20:03:46.995905, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username PROSERVE+user1, was [2010/07/26 20:03:46.995954, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 12 -> now SET [2010/07/26 20:03:46.995979, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2010/07/26 20:03:46.996004, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 13 -> now SET [2010/07/26 20:03:46.996033, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain CEPURE, was [2010/07/26 20:03:46.996057, 11] passdb/pdb_get_set.c:522(pdb_set_init_flags) element 14 -> now DEFAULT [2010/07/26 20:03:46.996084, 11] passdb/pdb_get_set.c:522(pdb_set_init_flags) element 20 -> now DEFAULT [2010/07/26 20:03:46.996109, 4] lib/substitute.c:504(automount_server) Home server: cepure [2010/07/26 20:03:46.996139, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path \\cepure\PROSERVE+user1\profile, was [2010/07/26 20:03:46.996169, 11] passdb/pdb_get_set.c:522(pdb_set_init_flags) element 2 -> now DEFAULT [2010/07/26 20:03:46.996193, 4] lib/substitute.c:504(automount_server) Home server: cepure [2010/07/26 20:03:46.996220, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir \\cepure\PROSERVE+user1, was [2010/07/26 20:03:46.996245, 11] passdb/pdb_get_set.c:522(pdb_set_init_flags) element 1 -> now DEFAULT [2010/07/26 20:03:46.996275, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2010/07/26 20:03:46.996300, 11] passdb/pdb_get_set.c:522(pdb_set_init_flags) element 3 -> now DEFAULT [2010/07/26 20:03:46.996325, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2010/07/26 20:03:46.996350, 11] passdb/pdb_get_set.c:522(pdb_set_init_flags) element 4 -> now DEFAULT [2010/07/26 20:03:46.996386, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4235160793-1365951415-1100996829-28454 [2010/07/26 20:03:46.996419, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 18 -> now SET [2010/07/26 20:03:46.996444, 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-4235160793-1365951415-1100996829-28454 from rid 28454 [2010/07/26 20:03:46.996482, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username user1, was [2010/07/26 20:03:46.996512, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 15 -> now CHANGED [2010/07/26 20:03:46.996536, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user1, was PROSERVE+user1 [2010/07/26 20:03:46.996560, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 12 -> now CHANGED [2010/07/26 20:03:46.996587, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain PROSERVE, was CEPURE [2010/07/26 20:03:46.996616, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 14 -> now CHANGED [2010/07/26 20:03:46.996640, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-851642300-2639045452-4037496937-3727 [2010/07/26 20:03:46.996666, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 18 -> now CHANGED [2010/07/26 20:03:46.996735, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-513, value = 10513, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.996771, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-513 -> gid 10513 [2010/07/26 20:03:46.996799, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-851642300-2639045452-4037496937-513 [2010/07/26 20:03:46.996826, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 19 -> now CHANGED [2010/07/26 20:03:46.996855, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2010/07/26 20:03:46.996879, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 13 -> now CHANGED [2010/07/26 20:03:46.996903, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2010/07/26 20:03:46.996928, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 4 -> now CHANGED [2010/07/26 20:03:46.996957, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path , was \\cepure\PROSERVE+user1\profile [2010/07/26 20:03:46.996982, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 2 -> now CHANGED [2010/07/26 20:03:46.997006, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir , was \\cepure\PROSERVE+user1 [2010/07/26 20:03:46.997030, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 1 -> now CHANGED [2010/07/26 20:03:46.997059, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was [2010/07/26 20:03:46.997083, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 3 -> now CHANGED [2010/07/26 20:03:46.997108, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 20 -> now CHANGED [2010/07/26 20:03:46.997132, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 21 -> now CHANGED [2010/07/26 20:03:46.997156, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 9 -> now CHANGED [2010/07/26 20:03:46.997185, 11] passdb/pdb_get_set.c:499(pdb_set_init_flags) element 10 -> now CHANGED [2010/07/26 20:03:46.997225, 3] auth/auth.c:265(check_ntlm_password) check_ntlm_password: winbind authentication for user [user1] succeeded [2010/07/26 20:03:46.997254, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:46.997279, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:46.997308, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:46.997333, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:46.997358, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:46.997411, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:46.997438, 5] auth/auth.c:291(check_ntlm_password) check_ntlm_password: PAM Account for user [PROSERVE+user1] succeeded [2010/07/26 20:03:46.997467, 2] auth/auth.c:304(check_ntlm_password) check_ntlm_password: authentication for user [user1] -> [user1] -> [PROSERVE+user1] succeeded [2010/07/26 20:03:46.997492, 5] auth/auth_util.c:2119(free_user_info) attempting to free (and zero) a user_info structure [2010/07/26 20:03:46.997516, 10] auth/auth_util.c:2123(free_user_info) structure was created for user1 [2010/07/26 20:03:46.997748, 10] auth/token_util.c:356(create_local_nt_token) Create local NT token for S-1-5-21-851642300-2639045452-4037496937-3727 [2010/07/26 20:03:46.997796, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:46.997822, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:46.997847, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:46.997871, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:46.997901, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:46.998654, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:46.998703, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-3727] [2010/07/26 20:03:46.998742, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-513] [2010/07/26 20:03:46.998780, 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 [2010/07/26 20:03:46.998833, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-2] [2010/07/26 20:03:46.998863, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-11] [2010/07/26 20:03:46.998899, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2527] [2010/07/26 20:03:46.998931, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2531] [2010/07/26 20:03:46.998963, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2526] [2010/07/26 20:03:46.999002, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2524] [2010/07/26 20:03:46.999034, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2530] [2010/07/26 20:03:46.999066, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2532] [2010/07/26 20:03:46.999104, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2523] [2010/07/26 20:03:46.999135, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2525] [2010/07/26 20:03:46.999167, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2529] [2010/07/26 20:03:46.999203, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2522] [2010/07/26 20:03:46.999235, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-21-851642300-2639045452-4037496937-2528] [2010/07/26 20:03:46.999266, 3] lib/privileges.c:63(get_privileges) get_privileges: No privileges assigned to SID [S-1-5-32-545] [2010/07/26 20:03:46.999301, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-11, value = 110004, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999335, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-11 -> gid 110004 [2010/07/26 20:03:46.999372, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2527, value = 12527, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999401, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2527 -> gid 12527 [2010/07/26 20:03:46.999445, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2531, value = 12531, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999474, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2531 -> gid 12531 [2010/07/26 20:03:46.999512, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2526, value = 12526, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999549, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2526 -> gid 12526 [2010/07/26 20:03:46.999587, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2524, value = 12524, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999621, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2524 -> gid 12524 [2010/07/26 20:03:46.999658, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2530, value = 12530, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999687, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2530 -> gid 12530 [2010/07/26 20:03:46.999724, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2532, value = 12532, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999758, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2532 -> gid 12532 [2010/07/26 20:03:46.999796, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2523, value = 12523, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999831, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2523 -> gid 12523 [2010/07/26 20:03:46.999868, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2525, value = 12525, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999897, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2525 -> gid 12525 [2010/07/26 20:03:46.999941, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2529, value = 12529, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:46.999969, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2529 -> gid 12529 [2010/07/26 20:03:47.000007, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2522, value = 12522, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:47.000041, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2522 -> gid 12522 [2010/07/26 20:03:47.000078, 10] lib/gencache.c:345(gencache_get_data_blob) Returning valid cache entry: key = IDMAP/SID2GID/S-1-5-21-851642300-2639045452-4037496937-2528, value = 12528, timeout = Mon Aug 2 17:57:40 2010 [2010/07/26 20:03:47.000107, 10] passdb/lookup_sid.c:1518(sid_to_gid) sid S-1-5-21-851642300-2639045452-4037496937-2528 -> gid 12528 [2010/07/26 20:03:47.000170, 10] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-851642300-2639045452-4037496937-3727 contains 34 SIDs SID[ 0]: S-1-5-21-851642300-2639045452-4037496937-3727 SID[ 1]: S-1-5-21-851642300-2639045452-4037496937-513 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SID[ 5]: S-1-5-21-851642300-2639045452-4037496937-2527 SID[ 6]: S-1-5-21-851642300-2639045452-4037496937-2531 SID[ 7]: S-1-5-21-851642300-2639045452-4037496937-2526 SID[ 8]: S-1-5-21-851642300-2639045452-4037496937-2524 SID[ 9]: S-1-5-21-851642300-2639045452-4037496937-2530 SID[ 10]: S-1-5-21-851642300-2639045452-4037496937-2532 SID[ 11]: S-1-5-21-851642300-2639045452-4037496937-2523 SID[ 12]: S-1-5-21-851642300-2639045452-4037496937-2525 SID[ 13]: S-1-5-21-851642300-2639045452-4037496937-2529 SID[ 14]: S-1-5-21-851642300-2639045452-4037496937-2522 SID[ 15]: S-1-5-21-851642300-2639045452-4037496937-2528 SID[ 16]: S-1-5-32-545 SID[ 17]: S-1-22-1-13727 SID[ 18]: S-1-22-2-10513 SID[ 19]: S-1-22-2-110002 SID[ 20]: S-1-22-2-110003 SID[ 21]: S-1-22-2-110004 SID[ 22]: S-1-22-2-12527 SID[ 23]: S-1-22-2-12531 SID[ 24]: S-1-22-2-12526 SID[ 25]: S-1-22-2-12524 SID[ 26]: S-1-22-2-12530 SID[ 27]: S-1-22-2-12532 SID[ 28]: S-1-22-2-12523 SID[ 29]: S-1-22-2-12525 SID[ 30]: S-1-22-2-12529 SID[ 31]: S-1-22-2-12522 SID[ 32]: S-1-22-2-12528 SID[ 33]: S-1-22-2-110001 SE_PRIV 0x0 0x0 0x0 0x0 [2010/07/26 20:03:47.000647, 10] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 13727 Primary group is 10513 and contains 16 supplementary groups Group[ 0]: 10513 Group[ 1]: 110002 Group[ 2]: 110003 Group[ 3]: 110004 Group[ 4]: 12527 Group[ 5]: 12531 Group[ 6]: 12526 Group[ 7]: 12524 Group[ 8]: 12530 Group[ 9]: 12532 Group[ 10]: 12523 Group[ 11]: 12525 Group[ 12]: 12529 Group[ 13]: 12522 Group[ 14]: 12528 Group[ 15]: 110001 [2010/07/26 20:03:47.000860, 10] auth/auth_ntlmssp.c:139(auth_ntlmssp_check_password) Got NT session key of length 16 [2010/07/26 20:03:47.000915, 10] auth/auth_ntlmssp.c:146(auth_ntlmssp_check_password) Got LM session key of length 8 [2010/07/26 20:03:47.000943, 10] libsmb/ntlmssp.c:815(ntlmssp_server_auth) ntlmssp_server_auth: Created NTLM2 session key. [2010/07/26 20:03:47.000972, 3] libsmb/ntlmssp_sign.c:343(ntlmssp_sign_init) NTLMSSP Sign/Seal - Initialising with flags: [2010/07/26 20:03:47.001003, 3] libsmb/ntlmssp.c:65(debug_ntlmssp_flags) Got NTLMSSP neg_flags=0x60088215 NTLMSSP_NEGOTIATE_UNICODE NTLMSSP_REQUEST_TARGET NTLMSSP_NEGOTIATE_SIGN NTLMSSP_NEGOTIATE_NTLM NTLMSSP_NEGOTIATE_ALWAYS_SIGN NTLMSSP_NEGOTIATE_NTLM2 NTLMSSP_NEGOTIATE_128 NTLMSSP_NEGOTIATE_KEY_EXCH [2010/07/26 20:03:47.001121, 10] smbd/password.c:278(register_existing_vuid) register_existing_vuid: (13727,10513) PROSERVE+user1 user1 PROSERVE guest=0 [2010/07/26 20:03:47.001147, 3] smbd/password.c:282(register_existing_vuid) register_existing_vuid: User name: PROSERVE+user1 Real name: [2010/07/26 20:03:47.001179, 3] smbd/password.c:292(register_existing_vuid) register_existing_vuid: UNIX uid 13727 is UNIX user PROSERVE+user1, and will be vuid 100 [2010/07/26 20:03:47.001208, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 49442F32353830362F31303000 [2010/07/26 20:03:47.001242, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x8994950 [2010/07/26 20:03:47.001335, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 49442F32353830362F31303000 [2010/07/26 20:03:47.001374, 7] param/loadparm.c:9399(lp_servicenumber) lp_servicenumber: couldn't find PROSERVE+user1 [2010/07/26 20:03:47.002181, 3] smbd/password.c:223(register_homes_share) Adding homes service for user 'PROSERVE+user1' using home directory: '/home/PROSERVE/user1' [2010/07/26 20:03:47.002227, 7] param/loadparm.c:9399(lp_servicenumber) lp_servicenumber: couldn't find homes [2010/07/26 20:03:47.002299, 6] param/loadparm.c:7133(lp_file_list_changed) lp_file_list_changed() file /opt/samba/lib/smb.conf -> /opt/samba/lib/smb.conf last mod_time: Mon Jul 26 18:46:25 2010 [2010/07/26 20:03:47.002405, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.003343, 5] lib/util.c:627(show_msg) size=104 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51203 smb_tid=0 smb_pid=25805 smb_uid=100 smb_mid=3 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 9 (0x9) smb_bcc=61 [2010/07/26 20:03:47.003594, 10] ../lib/util/util.c:278(_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 35 00 2E 00 34 00 00 00 50 00 52 00 4F ...5...4 ...P.R.O [0030] 00 53 00 45 00 52 00 56 00 45 00 00 00 .S.E.R.V .E... [2010/07/26 20:03:47.003916, 10] lib/util_sock.c:726(read_smb_length_return_keepalive) got smb length of 76 [2010/07/26 20:03:47.003964, 6] smbd/process.c:1482(process_smb) got message type 0x0 of len 0x4c [2010/07/26 20:03:47.003990, 3] smbd/process.c:1485(process_smb) Transaction 3 of length 80 (0 toread) [2010/07/26 20:03:47.004015, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.004029, 5] lib/util.c:627(show_msg) size=76 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=65535 smb_pid=25805 smb_uid=100 smb_mid=4 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 8 (0x8) smb_vwv[ 3]= 1 (0x1) smb_bcc=33 [2010/07/26 20:03:47.004231, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 5C 00 5C 00 43 00 45 00 50 00 55 00 52 00 45 .\.\.C.E .P.U.R.E [0010] 00 5C 00 49 00 50 00 43 00 24 00 00 00 49 50 43 .\.I.P.C .$...IPC [0020] 00 . [2010/07/26 20:03:47.004302, 3] smbd/process.c:1294(switch_message) switch message SMBtconX (pid 25806) conn 0x0 [2010/07/26 20:03:47.004409, 0] smbd/process.c:1243(smb_dump) created /tmp/SMBtconX.9.req len 80 [2010/07/26 20:03:47.004437, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.004463, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.004488, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.004545, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.004591, 4] smbd/reply.c:767(reply_tcon_and_X) Client requested device type [IPC] for share [IPC$] [2010/07/26 20:03:47.004631, 5] smbd/service.c:1227(make_connection) making a connection to 'normal' service ipc$ [2010/07/26 20:03:47.004674, 10] smbd/share_access.c:238(user_ok_token) user_ok_token: share IPC$ is ok for unix user PROSERVE+user1 [2010/07/26 20:03:47.004726, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 3: SET [2010/07/26 20:03:47.004753, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 3: CHANGED [2010/07/26 20:03:47.004777, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 1: SET [2010/07/26 20:03:47.004801, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 1: CHANGED [2010/07/26 20:03:47.004825, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 4: SET [2010/07/26 20:03:47.004849, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 4: CHANGED [2010/07/26 20:03:47.004880, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 2: SET [2010/07/26 20:03:47.004903, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 2: CHANGED [2010/07/26 20:03:47.004929, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.004955, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.004979, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.005010, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.005034, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.005095, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.005126, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.005161, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 0) -> 180 [2010/07/26 20:03:47.005187, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.005226, 18] lib/util_tdb.c:358(tdb_unpack) tdb_unpack(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.005253, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 5 -> now SET [2010/07/26 20:03:47.005285, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 6 -> now SET [2010/07/26 20:03:47.005309, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 7 -> now SET [2010/07/26 20:03:47.005333, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 8 -> now SET [2010/07/26 20:03:47.005357, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 9 -> now SET [2010/07/26 20:03:47.005381, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 10 -> now SET [2010/07/26 20:03:47.005413, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 21 -> now SET [2010/07/26 20:03:47.005437, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user1, was [2010/07/26 20:03:47.005461, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 12 -> now SET [2010/07/26 20:03:47.005485, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain PROSERVE, was [2010/07/26 20:03:47.005509, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 14 -> now SET [2010/07/26 20:03:47.005540, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username user1, was [2010/07/26 20:03:47.005564, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 15 -> now SET [2010/07/26 20:03:47.005588, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2010/07/26 20:03:47.005613, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 13 -> now SET [2010/07/26 20:03:47.005648, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir , was [2010/07/26 20:03:47.005673, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 1 -> now SET [2010/07/26 20:03:47.005696, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2010/07/26 20:03:47.005721, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 3 -> now SET [2010/07/26 20:03:47.005744, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2010/07/26 20:03:47.005780, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 4 -> now SET [2010/07/26 20:03:47.005804, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path , was [2010/07/26 20:03:47.005829, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 2 -> now SET [2010/07/26 20:03:47.005854, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 22 -> now SET [2010/07/26 20:03:47.005885, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 24 -> now SET [2010/07/26 20:03:47.005909, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2010/07/26 20:03:47.005933, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 23 -> now SET [2010/07/26 20:03:47.005957, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 25 -> now SET [2010/07/26 20:03:47.005983, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.006015, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.006040, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.006063, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.006087, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.006146, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.006177, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.006204, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 33 -> now SET [2010/07/26 20:03:47.006230, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4235160793-1365951415-1100996829-0 [2010/07/26 20:03:47.006264, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 18 -> now SET [2010/07/26 20:03:47.006288, 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-4235160793-1365951415-1100996829-0 from rid 0 [2010/07/26 20:03:47.006326, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 16 -> now SET [2010/07/26 20:03:47.006351, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 28 -> now SET [2010/07/26 20:03:47.006375, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 29 -> now SET [2010/07/26 20:03:47.006407, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 30 -> now SET [2010/07/26 20:03:47.006434, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 20 -> now SET [2010/07/26 20:03:47.006459, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 17 -> now SET [2010/07/26 20:03:47.006482, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 26 -> now SET [2010/07/26 20:03:47.006513, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-851642300-2639045452-4037496937-513 [2010/07/26 20:03:47.006547, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 19 -> now SET [2010/07/26 20:03:47.006585, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user PROSERVE+user1 [2010/07/26 20:03:47.006610, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is proserve+user1 [2010/07/26 20:03:47.006637, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [PROSERVE+user1]! [2010/07/26 20:03:47.006686, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service IPC$, connectpath = /tmp [2010/07/26 20:03:47.006714, 3] smbd/service.c:807(make_connection_snum) Connect path is '/tmp' for service [IPC$] [2010/07/26 20:03:47.006759, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2010/07/26 20:03:47.006800, 3] smbd/vfs.c:97(vfs_init_default) Initialising default vfs hooks [2010/07/26 20:03:47.006846, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ [2010/07/26 20:03:47.006872, 5] smbd/vfs.c:87(smb_register_vfs) Successfully added vfs backend '/[Default VFS]/' [2010/07/26 20:03:47.006919, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for solarisacl [2010/07/26 20:03:47.006944, 5] smbd/vfs.c:87(smb_register_vfs) Successfully added vfs backend 'solarisacl' [2010/07/26 20:03:47.006981, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for zfsacl [2010/07/26 20:03:47.007007, 5] smbd/vfs.c:87(smb_register_vfs) Successfully added vfs backend 'zfsacl' [2010/07/26 20:03:47.007031, 3] smbd/vfs.c:122(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2010/07/26 20:03:47.007056, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ Successfully loaded vfs module [/[Default VFS]/] with the new modules system [2010/07/26 20:03:47.007098, 3] smbd/vfs.c:122(vfs_init_custom) Initialising custom vfs hooks from [zfsacl] [2010/07/26 20:03:47.007123, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for zfsacl Successfully loaded vfs module [zfsacl] with the new modules system [2010/07/26 20:03:47.007161, 5] smbd/connection.c:142(claim_connection) claiming [IPC$] [2010/07/26 20:03:47.007210, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key CE6400000100000049504324000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.007252, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x89991a0 [2010/07/26 20:03:47.007287, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key CE6400000100000049504324000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.007399, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service IPC$, connectpath = /tmp [2010/07/26 20:03:47.007431, 10] smbd/share_access.c:238(user_ok_token) user_ok_token: share IPC$ is ok for unix user PROSERVE+user1 [2010/07/26 20:03:47.007458, 10] smbd/share_access.c:283(is_share_read_only_for_token) is_share_read_only_for_user: share IPC$ is read-only for unix user PROSERVE+user1 [2010/07/26 20:03:47.007499, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2010/07/26 20:03:47.007565, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 3: SET [2010/07/26 20:03:47.007592, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 3: CHANGED [2010/07/26 20:03:47.007616, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 1: SET [2010/07/26 20:03:47.007650, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 1: CHANGED [2010/07/26 20:03:47.007674, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 4: SET [2010/07/26 20:03:47.007698, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 4: CHANGED [2010/07/26 20:03:47.007722, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 2: SET [2010/07/26 20:03:47.007746, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 2: CHANGED [2010/07/26 20:03:47.007781, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.007806, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.007830, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.007855, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.007879, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.007934, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.007964, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.007991, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 0) -> 180 [2010/07/26 20:03:47.008017, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.008051, 18] lib/util_tdb.c:358(tdb_unpack) tdb_unpack(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.008077, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 5 -> now SET [2010/07/26 20:03:47.008103, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 6 -> now SET [2010/07/26 20:03:47.008127, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 7 -> now SET [2010/07/26 20:03:47.008158, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 8 -> now SET [2010/07/26 20:03:47.008183, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 9 -> now SET [2010/07/26 20:03:47.008207, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 10 -> now SET [2010/07/26 20:03:47.008231, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 21 -> now SET [2010/07/26 20:03:47.008254, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user1, was [2010/07/26 20:03:47.008286, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 12 -> now SET [2010/07/26 20:03:47.008310, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain PROSERVE, was [2010/07/26 20:03:47.008335, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 14 -> now SET [2010/07/26 20:03:47.008358, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username user1, was [2010/07/26 20:03:47.008383, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 15 -> now SET [2010/07/26 20:03:47.008414, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2010/07/26 20:03:47.008439, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 13 -> now SET [2010/07/26 20:03:47.008463, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir , was [2010/07/26 20:03:47.008488, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 1 -> now SET [2010/07/26 20:03:47.008519, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2010/07/26 20:03:47.008544, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 3 -> now SET [2010/07/26 20:03:47.008568, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2010/07/26 20:03:47.008592, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 4 -> now SET [2010/07/26 20:03:47.008616, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path , was [2010/07/26 20:03:47.008650, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 2 -> now SET [2010/07/26 20:03:47.008674, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 22 -> now SET [2010/07/26 20:03:47.008699, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 24 -> now SET [2010/07/26 20:03:47.008722, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2010/07/26 20:03:47.008756, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 23 -> now SET [2010/07/26 20:03:47.008781, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 25 -> now SET [2010/07/26 20:03:47.008806, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.008831, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.008855, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.008886, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.008911, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.008956, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.008986, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.009019, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 33 -> now SET [2010/07/26 20:03:47.009044, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4235160793-1365951415-1100996829-0 [2010/07/26 20:03:47.009071, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 18 -> now SET [2010/07/26 20:03:47.009094, 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-4235160793-1365951415-1100996829-0 from rid 0 [2010/07/26 20:03:47.009138, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 16 -> now SET [2010/07/26 20:03:47.009163, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 28 -> now SET [2010/07/26 20:03:47.009187, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 29 -> now SET [2010/07/26 20:03:47.009210, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 30 -> now SET [2010/07/26 20:03:47.009234, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 20 -> now SET [2010/07/26 20:03:47.009266, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 17 -> now SET [2010/07/26 20:03:47.009290, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 26 -> now SET [2010/07/26 20:03:47.009318, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-851642300-2639045452-4037496937-513 [2010/07/26 20:03:47.009344, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 19 -> now SET [2010/07/26 20:03:47.009384, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (13727, 10513) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.009409, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-851642300-2639045452-4037496937-3727 contains 34 SIDs SID[ 0]: S-1-5-21-851642300-2639045452-4037496937-3727 SID[ 1]: S-1-5-21-851642300-2639045452-4037496937-513 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SID[ 5]: S-1-5-21-851642300-2639045452-4037496937-2527 SID[ 6]: S-1-5-21-851642300-2639045452-4037496937-2531 SID[ 7]: S-1-5-21-851642300-2639045452-4037496937-2526 SID[ 8]: S-1-5-21-851642300-2639045452-4037496937-2524 SID[ 9]: S-1-5-21-851642300-2639045452-4037496937-2530 SID[ 10]: S-1-5-21-851642300-2639045452-4037496937-2532 SID[ 11]: S-1-5-21-851642300-2639045452-4037496937-2523 SID[ 12]: S-1-5-21-851642300-2639045452-4037496937-2525 SID[ 13]: S-1-5-21-851642300-2639045452-4037496937-2529 SID[ 14]: S-1-5-21-851642300-2639045452-4037496937-2522 SID[ 15]: S-1-5-21-851642300-2639045452-4037496937-2528 SID[ 16]: S-1-5-32-545 SID[ 17]: S-1-22-1-13727 SID[ 18]: S-1-22-2-10513 SID[ 19]: S-1-22-2-110002 SID[ 20]: S-1-22-2-110003 SID[ 21]: S-1-22-2-110004 SID[ 22]: S-1-22-2-12527 SID[ 23]: S-1-22-2-12531 SID[ 24]: S-1-22-2-12526 SID[ 25]: S-1-22-2-12524 SID[ 26]: S-1-22-2-12530 SID[ 27]: S-1-22-2-12532 SID[ 28]: S-1-22-2-12523 SID[ 29]: S-1-22-2-12525 SID[ 30]: S-1-22-2-12529 SID[ 31]: S-1-22-2-12522 SID[ 32]: S-1-22-2-12528 SID[ 33]: S-1-22-2-110001 SE_PRIV 0x0 0x0 0x0 0x0 [2010/07/26 20:03:47.009898, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 13727 Primary group is 10513 and contains 16 supplementary groups Group[ 0]: 10513 Group[ 1]: 110002 Group[ 2]: 110003 Group[ 3]: 110004 Group[ 4]: 12527 Group[ 5]: 12531 Group[ 6]: 12526 Group[ 7]: 12524 Group[ 8]: 12530 Group[ 9]: 12532 Group[ 10]: 12523 Group[ 11]: 12525 Group[ 12]: 12529 Group[ 13]: 12522 Group[ 14]: 12528 Group[ 15]: 110001 [2010/07/26 20:03:47.010119, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,13727) gid=(0,10513) [2010/07/26 20:03:47.010152, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service IPC$, connectpath = /tmp [2010/07/26 20:03:47.010195, 10] modules/vfs_default.c:152(vfswrap_fs_capabilities) vfswrap_fs_capabilities: timestamp resolution of sec available on share IPC$, directory /tmp [2010/07/26 20:03:47.010228, 3] smbd/service.c:1070(make_connection_snum) cepure (192.168.0.96) connect to service IPC$ initially as user PROSERVE+user1 (uid=13727, gid=10513) (pid 25806) [2010/07/26 20:03:47.010268, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.010292, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.010315, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.010368, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.010399, 3] smbd/reply.c:846(reply_tcon_and_X) tconX service=IPC$ [2010/07/26 20:03:47.010495, 10] lib/util_sock.c:726(read_smb_length_return_keepalive) got smb length of 98 [2010/07/26 20:03:47.010528, 6] smbd/process.c:1482(process_smb) got message type 0x0 of len 0x62 [2010/07/26 20:03:47.010553, 3] smbd/process.c:1485(process_smb) Transaction 4 of length 102 (0 toread) [2010/07/26 20:03:47.010586, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.010599, 5] lib/util.c:627(show_msg) size=98 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=5 smt_wct=15 smb_vwv[ 0]= 30 (0x1E) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]=16644 (0x4104) 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]= 30 (0x1E) smb_vwv[10]= 68 (0x44) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 98 (0x62) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 16 (0x10) smb_bcc=33 [2010/07/26 20:03:47.010913, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 44 20 03 00 5C 00 63 00 65 00 70 00 75 00 72 .D ..\.c .e.p.u.r [0010] 00 65 00 5C 00 53 00 41 00 4D 00 42 00 41 00 00 .e.\.S.A .M.B.A.. [0020] 00 . [2010/07/26 20:03:47.010982, 3] smbd/process.c:1294(switch_message) switch message SMBtrans2 (pid 25806) conn 0x899b600 [2010/07/26 20:03:47.011068, 0] smbd/process.c:1243(smb_dump) created /tmp/SMBtrans2.7.req len 102 [2010/07/26 20:03:47.011096, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (13727, 10513) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.011120, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-851642300-2639045452-4037496937-3727 contains 34 SIDs SID[ 0]: S-1-5-21-851642300-2639045452-4037496937-3727 SID[ 1]: S-1-5-21-851642300-2639045452-4037496937-513 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SID[ 5]: S-1-5-21-851642300-2639045452-4037496937-2527 SID[ 6]: S-1-5-21-851642300-2639045452-4037496937-2531 SID[ 7]: S-1-5-21-851642300-2639045452-4037496937-2526 SID[ 8]: S-1-5-21-851642300-2639045452-4037496937-2524 SID[ 9]: S-1-5-21-851642300-2639045452-4037496937-2530 SID[ 10]: S-1-5-21-851642300-2639045452-4037496937-2532 SID[ 11]: S-1-5-21-851642300-2639045452-4037496937-2523 SID[ 12]: S-1-5-21-851642300-2639045452-4037496937-2525 SID[ 13]: S-1-5-21-851642300-2639045452-4037496937-2529 SID[ 14]: S-1-5-21-851642300-2639045452-4037496937-2522 SID[ 15]: S-1-5-21-851642300-2639045452-4037496937-2528 SID[ 16]: S-1-5-32-545 SID[ 17]: S-1-22-1-13727 SID[ 18]: S-1-22-2-10513 SID[ 19]: S-1-22-2-110002 SID[ 20]: S-1-22-2-110003 SID[ 21]: S-1-22-2-110004 SID[ 22]: S-1-22-2-12527 SID[ 23]: S-1-22-2-12531 SID[ 24]: S-1-22-2-12526 SID[ 25]: S-1-22-2-12524 SID[ 26]: S-1-22-2-12530 SID[ 27]: S-1-22-2-12532 SID[ 28]: S-1-22-2-12523 SID[ 29]: S-1-22-2-12525 SID[ 30]: S-1-22-2-12529 SID[ 31]: S-1-22-2-12522 SID[ 32]: S-1-22-2-12528 SID[ 33]: S-1-22-2-110001 SE_PRIV 0x0 0x0 0x0 0x0 [2010/07/26 20:03:47.011594, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 13727 Primary group is 10513 and contains 16 supplementary groups Group[ 0]: 10513 Group[ 1]: 110002 Group[ 2]: 110003 Group[ 3]: 110004 Group[ 4]: 12527 Group[ 5]: 12531 Group[ 6]: 12526 Group[ 7]: 12524 Group[ 8]: 12530 Group[ 9]: 12532 Group[ 10]: 12523 Group[ 11]: 12525 Group[ 12]: 12529 Group[ 13]: 12522 Group[ 14]: 12528 Group[ 15]: 110001 [2010/07/26 20:03:47.011813, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,13727) gid=(0,10513) [2010/07/26 20:03:47.011846, 4] smbd/vfs.c:721(vfs_ChDir) vfs_ChDir to /tmp [2010/07/26 20:03:47.011894, 10] smbd/trans2.c:7996(call_trans2getdfsreferral) call_trans2getdfsreferral [2010/07/26 20:03:47.011945, 10] smbd/msdfs.c:107(parse_dfs_path) parse_dfs_path: temp = |cepure\SAMBA| after trimming \'s [2010/07/26 20:03:47.011970, 10] smbd/msdfs.c:132(parse_dfs_path) parse_dfs_path: hostname: cepure [2010/07/26 20:03:47.011994, 10] smbd/msdfs.c:174(parse_dfs_path) parse_dfs_path: servicename: SAMBA [2010/07/26 20:03:47.012021, 3] smbd/msdfs.c:848(get_referred_path) get_referred_path: |SAMBA| in dfs path \cepure\SAMBA is not a dfs root. [2010/07/26 20:03:47.012056, 3] smbd/error.c:80(error_packet_set) error packet at smbd/trans2.c(8018) cmd=50 (SMBtrans2) NT_STATUS_NOT_FOUND [2010/07/26 20:03:47.012089, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.012102, 5] lib/util.c:627(show_msg) size=35 smb_com=0x32 smb_rcls=37 smb_reh=2 smb_err=49152 smb_flg=136 smb_flg2=51203 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=5 smt_wct=0 smb_bcc=0 [2010/07/26 20:03:47.012269, 10] lib/util_sock.c:726(read_smb_length_return_keepalive) got smb length of 35 [2010/07/26 20:03:47.012307, 6] smbd/process.c:1482(process_smb) got message type 0x0 of len 0x23 [2010/07/26 20:03:47.012332, 3] smbd/process.c:1485(process_smb) Transaction 5 of length 39 (0 toread) [2010/07/26 20:03:47.012355, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.012368, 5] lib/util.c:627(show_msg) size=35 smb_com=0x71 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=6 smt_wct=0 smb_bcc=0 [2010/07/26 20:03:47.012538, 3] smbd/process.c:1294(switch_message) switch message SMBtdis (pid 25806) conn 0x899b600 [2010/07/26 20:03:47.012603, 0] smbd/process.c:1243(smb_dump) created /tmp/SMBtdis.7.req len 39 [2010/07/26 20:03:47.012629, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.012653, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.012677, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.012735, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.012776, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.012801, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.012825, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.012878, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.012903, 3] smbd/service.c:1251(close_cnum) cepure (192.168.0.96) closed connection to service IPC$ [2010/07/26 20:03:47.012930, 3] smbd/connection.c:31(yield_connection) Yielding connection to IPC$ [2010/07/26 20:03:47.012978, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key CE6400000100000049504324000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.013023, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x89be6e0 [2010/07/26 20:03:47.013055, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key CE6400000100000049504324000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.013117, 4] smbd/vfs.c:721(vfs_ChDir) vfs_ChDir to / [2010/07/26 20:03:47.013147, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.013172, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.013205, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.013245, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.013285, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.013299, 5] lib/util.c:627(show_msg) size=35 smb_com=0x71 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51203 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=6 smt_wct=0 smb_bcc=0 [2010/07/26 20:03:47.013510, 10] lib/util_sock.c:726(read_smb_length_return_keepalive) got smb length of 80 [2010/07/26 20:03:47.013538, 6] smbd/process.c:1482(process_smb) got message type 0x0 of len 0x50 [2010/07/26 20:03:47.013562, 3] smbd/process.c:1485(process_smb) Transaction 6 of length 84 (0 toread) [2010/07/26 20:03:47.013587, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.013600, 5] lib/util.c:627(show_msg) size=80 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=65535 smb_pid=25805 smb_uid=100 smb_mid=7 smt_wct=4 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 8 (0x8) smb_vwv[ 3]= 1 (0x1) smb_bcc=37 [2010/07/26 20:03:47.013797, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 5C 00 5C 00 43 00 45 00 50 00 55 00 52 00 45 .\.\.C.E .P.U.R.E [0010] 00 5C 00 53 00 41 00 4D 00 42 00 41 00 00 00 3F .\.S.A.M .B.A...? [0020] 3F 3F 3F 3F 00 ????. [2010/07/26 20:03:47.013878, 3] smbd/process.c:1294(switch_message) switch message SMBtconX (pid 25806) conn 0x0 [2010/07/26 20:03:47.013955, 0] smbd/process.c:1243(smb_dump) created /tmp/SMBtconX.10.req len 84 [2010/07/26 20:03:47.013982, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.014006, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.014030, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.014084, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.014113, 4] smbd/reply.c:767(reply_tcon_and_X) Client requested device type [?????] for share [SAMBA] [2010/07/26 20:03:47.014143, 5] smbd/service.c:1227(make_connection) making a connection to 'normal' service samba [2010/07/26 20:03:47.014173, 10] smbd/share_access.c:238(user_ok_token) user_ok_token: share SAMBA is ok for unix user PROSERVE+user1 [2010/07/26 20:03:47.014243, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 3: SET [2010/07/26 20:03:47.014267, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 3: CHANGED [2010/07/26 20:03:47.014291, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 1: SET [2010/07/26 20:03:47.014316, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 1: CHANGED [2010/07/26 20:03:47.014340, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 4: SET [2010/07/26 20:03:47.014373, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 4: CHANGED [2010/07/26 20:03:47.014396, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 2: SET [2010/07/26 20:03:47.014420, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 2: CHANGED [2010/07/26 20:03:47.014445, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.014469, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.014502, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.014526, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.014550, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.014596, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.014636, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.014662, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 0) -> 180 [2010/07/26 20:03:47.014687, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.014713, 18] lib/util_tdb.c:358(tdb_unpack) tdb_unpack(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.014748, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 5 -> now SET [2010/07/26 20:03:47.014772, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 6 -> now SET [2010/07/26 20:03:47.014796, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 7 -> now SET [2010/07/26 20:03:47.014820, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 8 -> now SET [2010/07/26 20:03:47.014844, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 9 -> now SET [2010/07/26 20:03:47.014877, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 10 -> now SET [2010/07/26 20:03:47.014901, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 21 -> now SET [2010/07/26 20:03:47.014925, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user1, was [2010/07/26 20:03:47.014949, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 12 -> now SET [2010/07/26 20:03:47.014973, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain PROSERVE, was [2010/07/26 20:03:47.015011, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 14 -> now SET [2010/07/26 20:03:47.015035, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username user1, was [2010/07/26 20:03:47.015059, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 15 -> now SET [2010/07/26 20:03:47.015082, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2010/07/26 20:03:47.015120, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 13 -> now SET [2010/07/26 20:03:47.015144, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir , was [2010/07/26 20:03:47.015169, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 1 -> now SET [2010/07/26 20:03:47.015192, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2010/07/26 20:03:47.015216, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 3 -> now SET [2010/07/26 20:03:47.015250, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2010/07/26 20:03:47.015274, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 4 -> now SET [2010/07/26 20:03:47.015298, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path , was [2010/07/26 20:03:47.015323, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 2 -> now SET [2010/07/26 20:03:47.015357, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 22 -> now SET [2010/07/26 20:03:47.015381, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 24 -> now SET [2010/07/26 20:03:47.015405, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2010/07/26 20:03:47.015430, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 23 -> now SET [2010/07/26 20:03:47.015454, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 25 -> now SET [2010/07/26 20:03:47.015489, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.015513, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.015537, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.015561, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.015584, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.015638, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.015670, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.015695, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 33 -> now SET [2010/07/26 20:03:47.015719, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4235160793-1365951415-1100996829-0 [2010/07/26 20:03:47.015756, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 18 -> now SET [2010/07/26 20:03:47.015779, 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-4235160793-1365951415-1100996829-0 from rid 0 [2010/07/26 20:03:47.015816, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 16 -> now SET [2010/07/26 20:03:47.015839, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 28 -> now SET [2010/07/26 20:03:47.015873, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 29 -> now SET [2010/07/26 20:03:47.015897, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 30 -> now SET [2010/07/26 20:03:47.015920, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 20 -> now SET [2010/07/26 20:03:47.015944, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 17 -> now SET [2010/07/26 20:03:47.015968, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 26 -> now SET [2010/07/26 20:03:47.016010, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-851642300-2639045452-4037496937-513 [2010/07/26 20:03:47.016036, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 19 -> now SET [2010/07/26 20:03:47.016061, 5] lib/username.c:133(Get_Pwnam_alloc) Finding user PROSERVE+user1 [2010/07/26 20:03:47.016085, 5] lib/username.c:77(Get_Pwnam_internals) Trying _Get_Pwnam(), username as lowercase is proserve+user1 [2010/07/26 20:03:47.016125, 5] lib/username.c:110(Get_Pwnam_internals) Get_Pwnam_internals did find user [PROSERVE+user1]! [2010/07/26 20:03:47.016164, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service SAMBA, connectpath = /SAMBA [2010/07/26 20:03:47.016191, 3] smbd/service.c:807(make_connection_snum) Connect path is '/SAMBA' for service [SAMBA] [2010/07/26 20:03:47.016224, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2010/07/26 20:03:47.016261, 3] smbd/vfs.c:97(vfs_init_default) Initialising default vfs hooks [2010/07/26 20:03:47.016286, 3] smbd/vfs.c:122(vfs_init_custom) Initialising custom vfs hooks from [/[Default VFS]/] [2010/07/26 20:03:47.016311, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for /[Default VFS]/ Successfully loaded vfs module [/[Default VFS]/] with the new modules system [2010/07/26 20:03:47.016347, 3] smbd/vfs.c:122(vfs_init_custom) Initialising custom vfs hooks from [zfsacl] [2010/07/26 20:03:47.016383, 10] smbd/vfs.c:48(vfs_find_backend_entry) vfs_find_backend_entry called for zfsacl Successfully loaded vfs module [zfsacl] with the new modules system [2010/07/26 20:03:47.016650, 5] smbd/connection.c:142(claim_connection) claiming [SAMBA] [2010/07/26 20:03:47.016702, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key CE6400000100000053414D42410000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.016748, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x898ff48 [2010/07/26 20:03:47.016794, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key CE6400000100000053414D42410000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.016873, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service SAMBA, connectpath = /SAMBA [2010/07/26 20:03:47.016905, 10] smbd/share_access.c:238(user_ok_token) user_ok_token: share SAMBA is ok for unix user PROSERVE+user1 [2010/07/26 20:03:47.016932, 10] smbd/share_access.c:283(is_share_read_only_for_token) is_share_read_only_for_user: share SAMBA is read-write for unix user PROSERVE+user1 [2010/07/26 20:03:47.016977, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2010/07/26 20:03:47.017011, 10] lib/util_seaccess.c:58(se_map_generic) se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2010/07/26 20:03:47.017040, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid @PROSERVE+domain admins does not start with 'S-'. [2010/07/26 20:03:47.017096, 5] smbd/password.c:423(user_in_netgroup) Unable to get default yp domain, let's try without specifying it [2010/07/26 20:03:47.017145, 5] smbd/password.c:430(user_in_netgroup) looking for user PROSERVE+user1 of domain (ANY) in netgroup PROSERVE+domain admins [2010/07/26 20:03:47.017300, 5] smbd/password.c:453(user_in_netgroup) looking for user proserve+user1 of domain (ANY) in netgroup PROSERVE+domain admins [2010/07/26 20:03:47.017354, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: PROSERVE\domain admins => PROSERVE (domain), domain admins (name) [2010/07/26 20:03:47.017397, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x077 [2010/07/26 20:03:47.017766, 3] lib/util_sid.c:228(string_to_sid) string_to_sid: Sid PROSERVE+administrator does not start with 'S-'. [2010/07/26 20:03:47.017797, 10] passdb/lookup_sid.c:69(lookup_name) lookup_name: PROSERVE\administrator => PROSERVE (domain), administrator (name) [2010/07/26 20:03:47.017822, 10] passdb/lookup_sid.c:70(lookup_name) lookup_name: flags = 0x073 [2010/07/26 20:03:47.018117, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 3: SET [2010/07/26 20:03:47.018145, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 3: CHANGED [2010/07/26 20:03:47.018169, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 1: SET [2010/07/26 20:03:47.018193, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 1: CHANGED [2010/07/26 20:03:47.018217, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 4: SET [2010/07/26 20:03:47.018253, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 4: CHANGED [2010/07/26 20:03:47.018280, 11] passdb/pdb_get_set.c:299(pdb_get_init_flags) element 2: SET [2010/07/26 20:03:47.018305, 11] passdb/pdb_get_set.c:304(pdb_get_init_flags) element 2: CHANGED [2010/07/26 20:03:47.018332, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.018358, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.018395, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.018420, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.018445, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.018498, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.018529, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.018569, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 0) -> 180 [2010/07/26 20:03:47.018596, 18] lib/util_tdb.c:204(tdb_pack_va) tdb_pack_va(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.018623, 18] lib/util_tdb.c:358(tdb_unpack) tdb_unpack(dddddddBBBBBBBBBBBBddBBBdwdBwwd, 180) -> 180 [2010/07/26 20:03:47.018649, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 5 -> now SET [2010/07/26 20:03:47.018685, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 6 -> now SET [2010/07/26 20:03:47.018709, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 7 -> now SET [2010/07/26 20:03:47.018733, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 8 -> now SET [2010/07/26 20:03:47.018757, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 9 -> now SET [2010/07/26 20:03:47.018781, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 10 -> now SET [2010/07/26 20:03:47.018816, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 21 -> now SET [2010/07/26 20:03:47.018840, 10] passdb/pdb_get_set.c:608(pdb_set_username) pdb_set_username: setting username user1, was [2010/07/26 20:03:47.018864, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 12 -> now SET [2010/07/26 20:03:47.018887, 10] passdb/pdb_get_set.c:631(pdb_set_domain) pdb_set_domain: setting domain PROSERVE, was [2010/07/26 20:03:47.018912, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 14 -> now SET [2010/07/26 20:03:47.018951, 10] passdb/pdb_get_set.c:654(pdb_set_nt_username) pdb_set_nt_username: setting nt username user1, was [2010/07/26 20:03:47.018975, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 15 -> now SET [2010/07/26 20:03:47.018999, 10] passdb/pdb_get_set.c:677(pdb_set_fullname) pdb_set_full_name: setting full name , was [2010/07/26 20:03:47.019023, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 13 -> now SET [2010/07/26 20:03:47.019062, 10] passdb/pdb_get_set.c:770(pdb_set_homedir) pdb_set_homedir: setting home dir , was [2010/07/26 20:03:47.019087, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 1 -> now SET [2010/07/26 20:03:47.019111, 10] passdb/pdb_get_set.c:746(pdb_set_dir_drive) pdb_set_dir_drive: setting dir drive , was NULL [2010/07/26 20:03:47.019135, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 3 -> now SET [2010/07/26 20:03:47.019159, 10] passdb/pdb_get_set.c:700(pdb_set_logon_script) pdb_set_logon_script: setting logon script , was [2010/07/26 20:03:47.019194, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 4 -> now SET [2010/07/26 20:03:47.019218, 10] passdb/pdb_get_set.c:723(pdb_set_profile_path) pdb_set_profile_path: setting profile path , was [2010/07/26 20:03:47.019243, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 2 -> now SET [2010/07/26 20:03:47.019267, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 22 -> now SET [2010/07/26 20:03:47.019302, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 24 -> now SET [2010/07/26 20:03:47.019326, 10] passdb/pdb_get_set.c:813(pdb_set_workstations) pdb_set_workstations: setting workstations , was [2010/07/26 20:03:47.019350, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 23 -> now SET [2010/07/26 20:03:47.019374, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 25 -> now SET [2010/07/26 20:03:47.019400, 3] smbd/sec_ctx.c:210(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.019436, 3] smbd/uid.c:429(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2010/07/26 20:03:47.019460, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2010/07/26 20:03:47.019484, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.019508, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.019565, 10] lib/account_pol.c:333(account_policy_get) account_policy_get: name: password history, val: 0 [2010/07/26 20:03:47.019595, 3] smbd/sec_ctx.c:418(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.019622, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 33 -> now SET [2010/07/26 20:03:47.019646, 10] passdb/pdb_get_set.c:537(pdb_set_user_sid) pdb_set_user_sid: setting user sid S-1-5-21-4235160793-1365951415-1100996829-0 [2010/07/26 20:03:47.019687, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 18 -> now SET [2010/07/26 20:03:47.019711, 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-4235160793-1365951415-1100996829-0 from rid 0 [2010/07/26 20:03:47.019748, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 16 -> now SET [2010/07/26 20:03:47.019771, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 28 -> now SET [2010/07/26 20:03:47.019806, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 29 -> now SET [2010/07/26 20:03:47.019830, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 30 -> now SET [2010/07/26 20:03:47.019854, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 20 -> now SET [2010/07/26 20:03:47.019878, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 17 -> now SET [2010/07/26 20:03:47.019902, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 26 -> now SET [2010/07/26 20:03:47.019946, 10] passdb/pdb_get_set.c:595(pdb_set_group_sid) pdb_set_group_sid: setting group sid S-1-5-21-851642300-2639045452-4037496937-513 [2010/07/26 20:03:47.019972, 11] passdb/pdb_get_set.c:510(pdb_set_init_flags) element 19 -> now SET [2010/07/26 20:03:47.020006, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (13727, 10513) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.020032, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-851642300-2639045452-4037496937-3727 contains 34 SIDs SID[ 0]: S-1-5-21-851642300-2639045452-4037496937-3727 SID[ 1]: S-1-5-21-851642300-2639045452-4037496937-513 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SID[ 5]: S-1-5-21-851642300-2639045452-4037496937-2527 SID[ 6]: S-1-5-21-851642300-2639045452-4037496937-2531 SID[ 7]: S-1-5-21-851642300-2639045452-4037496937-2526 SID[ 8]: S-1-5-21-851642300-2639045452-4037496937-2524 SID[ 9]: S-1-5-21-851642300-2639045452-4037496937-2530 SID[ 10]: S-1-5-21-851642300-2639045452-4037496937-2532 SID[ 11]: S-1-5-21-851642300-2639045452-4037496937-2523 SID[ 12]: S-1-5-21-851642300-2639045452-4037496937-2525 SID[ 13]: S-1-5-21-851642300-2639045452-4037496937-2529 SID[ 14]: S-1-5-21-851642300-2639045452-4037496937-2522 SID[ 15]: S-1-5-21-851642300-2639045452-4037496937-2528 SID[ 16]: S-1-5-32-545 SID[ 17]: S-1-22-1-13727 SID[ 18]: S-1-22-2-10513 SID[ 19]: S-1-22-2-110002 SID[ 20]: S-1-22-2-110003 SID[ 21]: S-1-22-2-110004 SID[ 22]: S-1-22-2-12527 SID[ 23]: S-1-22-2-12531 SID[ 24]: S-1-22-2-12526 SID[ 25]: S-1-22-2-12524 SID[ 26]: S-1-22-2-12530 SID[ 27]: S-1-22-2-12532 SID[ 28]: S-1-22-2-12523 SID[ 29]: S-1-22-2-12525 SID[ 30]: S-1-22-2-12529 SID[ 31]: S-1-22-2-12522 SID[ 32]: S-1-22-2-12528 SID[ 33]: S-1-22-2-110001 SE_PRIV 0x0 0x0 0x0 0x0 [2010/07/26 20:03:47.020524, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 13727 Primary group is 10513 and contains 16 supplementary groups Group[ 0]: 10513 Group[ 1]: 110002 Group[ 2]: 110003 Group[ 3]: 110004 Group[ 4]: 12527 Group[ 5]: 12531 Group[ 6]: 12526 Group[ 7]: 12524 Group[ 8]: 12530 Group[ 9]: 12532 Group[ 10]: 12523 Group[ 11]: 12525 Group[ 12]: 12529 Group[ 13]: 12522 Group[ 14]: 12528 Group[ 15]: 110001 [2010/07/26 20:03:47.020747, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,13727) gid=(0,10513) [2010/07/26 20:03:47.020787, 10] smbd/service.c:163(set_conn_connectpath) set_conn_connectpath: service SAMBA, connectpath = /SAMBA [2010/07/26 20:03:47.020842, 10] modules/vfs_default.c:152(vfswrap_fs_capabilities) vfswrap_fs_capabilities: timestamp resolution of sec available on share SAMBA, directory /SAMBA [2010/07/26 20:03:47.020902, 1] smbd/service.c:1070(make_connection_snum) cepure (192.168.0.96) connect to service SAMBA initially as user PROSERVE+user1 (uid=13727, gid=10513) (pid 25806) [2010/07/26 20:03:47.020933, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.020969, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.020993, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.021038, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.021072, 3] smbd/reply.c:846(reply_tcon_and_X) tconX service=SAMBA [2010/07/26 20:03:47.021185, 10] lib/util_sock.c:726(read_smb_length_return_keepalive) got smb length of 88 [2010/07/26 20:03:47.021231, 6] smbd/process.c:1482(process_smb) got message type 0x0 of len 0x58 [2010/07/26 20:03:47.021256, 3] smbd/process.c:1485(process_smb) Transaction 7 of length 92 (0 toread) [2010/07/26 20:03:47.021280, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.021293, 5] lib/util.c:627(show_msg) size=88 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=8 smt_wct=15 smb_vwv[ 0]= 20 (0x14) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 2 (0x2) smb_vwv[ 3]=16644 (0x4104) 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]= 20 (0x14) smb_vwv[10]= 68 (0x44) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 88 (0x58) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 5 (0x5) smb_bcc=23 [2010/07/26 20:03:47.021615, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 44 20 01 01 00 00 00 00 5C 00 73 00 68 00 61 .D ..... .\.s.h.a [0010] 00 72 00 65 00 00 00 .r.e... [2010/07/26 20:03:47.021684, 3] smbd/process.c:1294(switch_message) switch message SMBtrans2 (pid 25806) conn 0x899b600 [2010/07/26 20:03:47.021764, 0] smbd/process.c:1243(smb_dump) created /tmp/SMBtrans2.8.req len 92 [2010/07/26 20:03:47.021792, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (13727, 10513) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.021829, 5] auth/token_util.c:531(debug_nt_user_token) NT user token of user S-1-5-21-851642300-2639045452-4037496937-3727 contains 34 SIDs SID[ 0]: S-1-5-21-851642300-2639045452-4037496937-3727 SID[ 1]: S-1-5-21-851642300-2639045452-4037496937-513 SID[ 2]: S-1-1-0 SID[ 3]: S-1-5-2 SID[ 4]: S-1-5-11 SID[ 5]: S-1-5-21-851642300-2639045452-4037496937-2527 SID[ 6]: S-1-5-21-851642300-2639045452-4037496937-2531 SID[ 7]: S-1-5-21-851642300-2639045452-4037496937-2526 SID[ 8]: S-1-5-21-851642300-2639045452-4037496937-2524 SID[ 9]: S-1-5-21-851642300-2639045452-4037496937-2530 SID[ 10]: S-1-5-21-851642300-2639045452-4037496937-2532 SID[ 11]: S-1-5-21-851642300-2639045452-4037496937-2523 SID[ 12]: S-1-5-21-851642300-2639045452-4037496937-2525 SID[ 13]: S-1-5-21-851642300-2639045452-4037496937-2529 SID[ 14]: S-1-5-21-851642300-2639045452-4037496937-2522 SID[ 15]: S-1-5-21-851642300-2639045452-4037496937-2528 SID[ 16]: S-1-5-32-545 SID[ 17]: S-1-22-1-13727 SID[ 18]: S-1-22-2-10513 SID[ 19]: S-1-22-2-110002 SID[ 20]: S-1-22-2-110003 SID[ 21]: S-1-22-2-110004 SID[ 22]: S-1-22-2-12527 SID[ 23]: S-1-22-2-12531 SID[ 24]: S-1-22-2-12526 SID[ 25]: S-1-22-2-12524 SID[ 26]: S-1-22-2-12530 SID[ 27]: S-1-22-2-12532 SID[ 28]: S-1-22-2-12523 SID[ 29]: S-1-22-2-12525 SID[ 30]: S-1-22-2-12529 SID[ 31]: S-1-22-2-12522 SID[ 32]: S-1-22-2-12528 SID[ 33]: S-1-22-2-110001 SE_PRIV 0x0 0x0 0x0 0x0 [2010/07/26 20:03:47.022296, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 13727 Primary group is 10513 and contains 16 supplementary groups Group[ 0]: 10513 Group[ 1]: 110002 Group[ 2]: 110003 Group[ 3]: 110004 Group[ 4]: 12527 Group[ 5]: 12531 Group[ 6]: 12526 Group[ 7]: 12524 Group[ 8]: 12530 Group[ 9]: 12532 Group[ 10]: 12523 Group[ 11]: 12525 Group[ 12]: 12529 Group[ 13]: 12522 Group[ 14]: 12528 Group[ 15]: 110001 [2010/07/26 20:03:47.022537, 5] smbd/uid.c:354(change_to_user) change_to_user uid=(0,13727) gid=(0,10513) [2010/07/26 20:03:47.022577, 4] smbd/vfs.c:721(vfs_ChDir) vfs_ChDir to /SAMBA [2010/07/26 20:03:47.022621, 3] smbd/trans2.c:5099(call_trans2qfilepathinfo) call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 257 [2010/07/26 20:03:47.022669, 5] smbd/filename.c:169(unix_convert) unix_convert called on file "share" [2010/07/26 20:03:47.022702, 5] smbd/filename.c:328(unix_convert) unix_convert begin: name = share, dirpath = , start = share [2010/07/26 20:03:47.022736, 5] smbd/filename.c:351(unix_convert) conversion of base_name finished share -> share [2010/07/26 20:03:47.022778, 3] smbd/vfs.c:851(check_reduced_name) check_reduced_name [share] [/SAMBA] [2010/07/26 20:03:47.022819, 10] smbd/vfs.c:938(check_reduced_name) check_reduced_name realpath [share] -> [/SAMBA/share] [2010/07/26 20:03:47.022845, 3] smbd/vfs.c:1008(check_reduced_name) check_reduced_name: share reduced to /SAMBA/share [2010/07/26 20:03:47.022893, 10] locking/locking.c:926(fetch_share_mode_unlocked) fetch_share_mode_unlocked: no share_mode record around (file not open) [2010/07/26 20:03:47.022951, 3] smbd/trans2.c:5225(call_trans2qfilepathinfo) call_trans2qfilepathinfo share (fnum = -1) level=257 call=5 total_data=0 [2010/07/26 20:03:47.022981, 5] smbd/trans2.c:4197(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: share (fnum = -1) level=257 max_data=16644 [2010/07/26 20:03:47.023010, 8] smbd/dosmode.c:613(dos_mode) dos_mode: share [2010/07/26 20:03:47.023036, 8] smbd/dosmode.c:207(dos_mode_from_sbuf) dos_mode_from_sbuf returning rd [2010/07/26 20:03:47.023081, 8] smbd/dosmode.c:666(dos_mode) dos_mode returning rd [2010/07/26 20:03:47.023125, 10] smbd/trans2.c:4428(smbd_do_qfilepathinfo) smbd_do_qfilepathinfo: SMB_QUERY_FILE_BASIC_INFO [2010/07/26 20:03:47.023154, 5] smbd/trans2.c:4441(smbd_do_qfilepathinfo) SMB_QFBI - create: Mon Jul 26 11:25:48 2010 access: Mon Jul 26 18:21:02 2010 write: Mon Jul 26 11:25:48 2010 change: Mon Jul 26 11:25:48 2010 mode: 11 [2010/07/26 20:03:47.023245, 9] smbd/trans2.c:927(send_trans2_replies) t2_rep: params_sent_thistime = 2, data_sent_thistime = 36, useable_space = 131010 [2010/07/26 20:03:47.023270, 9] smbd/trans2.c:929(send_trans2_replies) t2_rep: params_to_send = 2, data_to_send = 36, paramsize = 2, datasize = 36 [2010/07/26 20:03:47.023295, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.023308, 5] lib/util.c:627(show_msg) size=96 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51203 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=8 smt_wct=10 smb_vwv[ 0]= 2 (0x2) smb_vwv[ 1]= 36 (0x24) smb_vwv[ 2]= 0 (0x0) smb_vwv[ 3]= 2 (0x2) smb_vwv[ 4]= 56 (0x38) smb_vwv[ 5]= 0 (0x0) smb_vwv[ 6]= 36 (0x24) smb_vwv[ 7]= 60 (0x3C) smb_vwv[ 8]= 0 (0x0) smb_vwv[ 9]= 0 (0x0) smb_bcc=41 [2010/07/26 20:03:47.023570, 10] ../lib/util/util.c:278(_dump_data) [0000] 00 00 00 00 00 86 25 8D 26 9C 2C CB 01 75 57 89 ......%. &.,..uW. [0010] 28 D6 2C CB 01 86 25 8D 26 9C 2C CB 01 86 25 8D (.,...%. &.,...%. [0020] 26 9C 2C CB 01 11 00 00 00 &.,..... . [2010/07/26 20:03:47.023684, 10] lib/util_sock.c:726(read_smb_length_return_keepalive) got smb length of 35 [2010/07/26 20:03:47.023713, 6] smbd/process.c:1482(process_smb) got message type 0x0 of len 0x23 [2010/07/26 20:03:47.023738, 3] smbd/process.c:1485(process_smb) Transaction 8 of length 39 (0 toread) [2010/07/26 20:03:47.023761, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.023787, 5] lib/util.c:627(show_msg) size=35 smb_com=0x71 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51201 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=9 smt_wct=0 smb_bcc=0 [2010/07/26 20:03:47.023932, 3] smbd/process.c:1294(switch_message) switch message SMBtdis (pid 25806) conn 0x899b600 [2010/07/26 20:03:47.024004, 0] smbd/process.c:1243(smb_dump) created /tmp/SMBtdis.8.req len 39 [2010/07/26 20:03:47.024030, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.024068, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.024092, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.024137, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.024166, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.024203, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.024227, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.024267, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.024293, 1] smbd/service.c:1251(close_cnum) cepure (192.168.0.96) closed connection to service SAMBA [2010/07/26 20:03:47.024339, 3] smbd/connection.c:31(yield_connection) Yielding connection to SAMBA [2010/07/26 20:03:47.024387, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key CE6400000100000053414D42410000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.024442, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x89be6e0 [2010/07/26 20:03:47.024474, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key CE6400000100000053414D42410000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.024539, 4] smbd/vfs.c:721(vfs_ChDir) vfs_ChDir to / [2010/07/26 20:03:47.024581, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.024606, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.024630, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.024670, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.024702, 5] lib/messages.c:329(messaging_deregister) Deregistering messaging pointer for type 784 - private_data=89987a8 [2010/07/26 20:03:47.024772, 5] lib/util.c:617(show_msg) [2010/07/26 20:03:47.024787, 5] lib/util.c:627(show_msg) size=35 smb_com=0x71 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51203 smb_tid=1 smb_pid=25805 smb_uid=100 smb_mid=9 smt_wct=0 smb_bcc=0 [2010/07/26 20:03:47.024971, 5] lib/util_sock.c:462(read_fd_with_timeout) read_fd_with_timeout: blocking read. EOF from client. [2010/07/26 20:03:47.025011, 10] smbd/process.c:286(receive_smb_raw_talloc) receive_smb_raw: NT_STATUS_END_OF_FILE [2010/07/26 20:03:47.025036, 3] smbd/sec_ctx.c:310(set_sec_ctx) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2010/07/26 20:03:47.025061, 5] auth/token_util.c:525(debug_nt_user_token) NT user token: (NULL) [2010/07/26 20:03:47.025084, 5] auth/token_util.c:551(debug_unix_user_token) UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2010/07/26 20:03:47.025142, 5] smbd/uid.c:369(change_to_root_user) change_to_root_user: now uid=(0,0) gid=(0,0) [2010/07/26 20:03:47.025173, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key 49442F32353830362F31303000 [2010/07/26 20:03:47.025204, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x8995930 [2010/07/26 20:03:47.025236, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key 49442F32353830362F31303000 [2010/07/26 20:03:47.025282, 3] smbd/connection.c:31(yield_connection) Yielding connection to [2010/07/26 20:03:47.025348, 10] lib/dbwrap_tdb.c:100(db_tdb_fetch_locked) Locking key CE640000FFFFFFFF00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.025405, 10] lib/dbwrap_tdb.c:129(db_tdb_fetch_locked) Allocated locked data 0x899b210 [2010/07/26 20:03:47.025437, 10] lib/dbwrap_tdb.c:42(db_tdb_record_destr) Unlocking key CE640000FFFFFFFF00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 [2010/07/26 20:03:47.025588, 3] smbd/server.c:902(exit_server_common) Server exit (failed to receive smb request)