[2009/03/30 01:08:46, 6] lp_file_list_changed() file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Mon Mar 30 01:08:28 2009 [2009/03/30 01:08:46, 5, class=auth] make_user_info_map: Mapping user [INTRA]\[guy] from workstation [HELLGATE] [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5, class=auth] is_trusted_domain: Checking for domain trust with [INTRA] [2009/03/30 01:08:46, 10, class=passdb] ldapsam_get_trusteddom_pw called for domain INTRA [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [sambaDomainName=INTRA,sambaDomainName=KORN,dc=intra,dc=guy], filter => [(&(objectClass=sambaTrustedDomainPassword)(sambaDomainName=INTRA))], scope => [2] [2009/03/30 01:08:46, 5] The connection to the LDAP server was closed [2009/03/30 01:08:46, 10] smb_ldap_setup_connection: ldap://192.168.0.99/ [2009/03/30 01:08:46, 2] smbldap_open_connection: connection opened [2009/03/30 01:08:46, 10] ldap_connect_system: Binding to ldap server ldap://192.168.0.99/ as "cn=admin,dc=intra,dc=guy" [2009/03/30 01:08:46, 3] ldap_connect_system: successful connection to the LDAP server ldap_connect_system: LDAP server does support paged results [2009/03/30 01:08:46, 10] Destroying timed event d89fd0 "smbldap_idle_fn" [2009/03/30 01:08:46, 10] Added timed event "smbldap_idle_fn": d81400 [2009/03/30 01:08:46, 4] The LDAP server is successfully connected [2009/03/30 01:08:46, 10] Failed search for base: sambaDomainName=INTRA,sambaDomainName=KORN,dc=intra,dc=guy, error: 32 (No such object) (unknown) [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10, class=tdb] Cache entry with key = TDOM/INTRA couldn't be found [2009/03/30 01:08:46, 5] no entry for trusted domain INTRA found. [2009/03/30 01:08:46, 5, class=auth] attempting to make a user_info for guy (guy) [2009/03/30 01:08:46, 5, class=auth] making strings for guy's user_info struct [2009/03/30 01:08:46, 5, class=auth] making blobs for guy's user_info struct [2009/03/30 01:08:46, 10, class=auth] made an encrypted user_info for guy (guy) [2009/03/30 01:08:46, 3, class=auth] check_ntlm_password: Checking password for unmapped user [INTRA]\[guy]@[HELLGATE] with the new password interface [2009/03/30 01:08:46, 3, class=auth] check_ntlm_password: mapped user is: [KORN]\[guy]@[HELLGATE] [2009/03/30 01:08:46, 10, class=auth] check_ntlm_password: auth_context challenge created by NTLMSSP callback (NTLM2) [2009/03/30 01:08:46, 10, class=auth] challenge is: [2009/03/30 01:08:46, 5] [000] 65 CD E8 2B 54 9E F7 DC e..+T... [2009/03/30 01:08:46, 10, class=auth] check_ntlm_password: guest had nothing to say [2009/03/30 01:08:46, 8] is_myname("KORN") returns 0 [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [dc=intra,dc=guy], filter => [(&(uid=guy)(objectclass=sambaSamAccount))], scope => [2] [2009/03/30 01:08:46, 2, class=passdb] init_sam_from_ldap: Entry found for user: guy [2009/03/30 01:08:46, 10, class=passdb] pdb_set_username: setting username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_domain: setting domain KORN, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_nt_username: setting nt username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid_from_string: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 [2009/03/30 01:08:46, 10] attribute sambaLogonTime does not exist [2009/03/30 01:08:46, 10] attribute sambaLogoffTime does not exist [2009/03/30 01:08:46, 10] attribute sambaKickoffTime does not exist [2009/03/30 01:08:46, 10] attribute sambaPwdCanChange does not exist [2009/03/30 01:08:46, 10] attribute sambaPwdMustChange does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_full_name: setting full name Korn András, was [2009/03/30 01:08:46, 10] attribute sambaHomeDrive does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_dir_drive: setting dir drive N:, was NULL [2009/03/30 01:08:46, 10] attribute sambaHomePath does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_homedir: setting home dir \\pdc\%u\profile, was [2009/03/30 01:08:46, 10] attribute sambaLogonScript does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_logon_script: setting logon script %u.cmd, was [2009/03/30 01:08:46, 10] attribute sambaProfilePath does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_profile_path: setting profile path , was [2009/03/30 01:08:46, 10] attribute description does not exist [2009/03/30 01:08:46, 10] attribute sambaUserWorkstations does not exist [2009/03/30 01:08:46, 10] attribute sambaMungedDial does not exist [2009/03/30 01:08:46, 10] attribute sambaLMPassword does not exist [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 10] attribute sambaBadPasswordCount does not exist [2009/03/30 01:08:46, 10] attribute sambaBadPasswordTime does not exist [2009/03/30 01:08:46, 10] attribute sambaLogonHours does not exist [2009/03/30 01:08:46, 7, class=passdb] Looking up login cache for user guy [2009/03/30 01:08:46, 7, class=passdb] No cache entry found [2009/03/30 01:08:46, 9, class=passdb] No cache entry, bad count = 0, bad time = 0 [2009/03/30 01:08:46, 5] Finding user guy [2009/03/30 01:08:46, 5] Trying _Get_Pwnam(), username as lowercase is guy [2009/03/30 01:08:46, 5] Get_Pwnam_internals did find user [guy]! [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(gidNumber=1000))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getgroup: Did not find group, filter was (&(objectClass=sambaGroupMapping)(gidNumber=1000)) [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_username: setting username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_domain: setting domain KORN, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_nt_username: setting nt username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_full_name: setting full name Korn András, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_homedir: setting home dir \\pdc\%u\profile, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_dir_drive: setting dir drive N:, was NULL [2009/03/30 01:08:46, 10, class=passdb] pdb_set_logon_script: setting logon script %u.cmd, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_profile_path: setting profile path , was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_workstations: setting workstations , was [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid_from_rid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 from rid 3000 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 9, class=passdb] pdb_update_autolock_flag: Account guy not autolocked, no check needed [2009/03/30 01:08:46, 4, class=auth] ntlm_password_check: Checking NT MD4 password [2009/03/30 01:08:46, 4, class=auth] sam_account_ok: Checking SMB password for user guy [2009/03/30 01:08:46, 5, class=auth] logon_hours_ok: user guy allowed to logon at this time (Sun Mar 29 23:08:46 2009 ) [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [dc=intra,dc=guy], filter => [(&(objectClass=sambaSamAccount)(uid=guy))], scope => [2] [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=posixGroup)(|(memberUid=guy)(gidNumber=1000)))], scope => [2] [2009/03/30 01:08:46, 10] smbldap_get_single_attribute: [sambaSID] = [] [2009/03/30 01:08:46, 10] smbldap_get_single_attribute: [sambaSID] = [] [2009/03/30 01:08:46, 10] smbldap_get_single_attribute: [sambaSID] = [] [2009/03/30 01:08:46, 10] smbldap_get_single_attribute: [sambaSID] = [] [2009/03/30 01:08:46, 3, class=passdb] primary group of [guy] not found [2009/03/30 01:08:46, 5, class=auth] make_server_info_sam: made server info for user guy -> guy [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3, class=auth] check_ntlm_password: sam authentication for user [guy] succeeded [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: Init user: guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: setting rhost to: hellgate.intra.guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: setting tty [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: Init passed for user: guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_account: PAM: Account Management for User: guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_account: PAM: Account OK for User: guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_end: PAM: PAM_END OK. [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5, class=auth] check_ntlm_password: PAM Account for user [guy] succeeded [2009/03/30 01:08:46, 2, class=auth] check_ntlm_password: authentication for user [guy] -> [guy] -> [guy] succeeded [2009/03/30 01:08:46, 5, class=auth] attempting to free (and zero) a user_info structure [2009/03/30 01:08:46, 10, class=auth] structure was created for guy [2009/03/30 01:08:46, 10] Create local NT token for S-1-5-21-655183313-499555889-1571944852-3000 [2009/03/30 01:08:46, 10, class=tdb] Cache entry with key = IDMAP/SID2GID/S-1-5-32-544 couldn't be found [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-32-544))], scope => [2] [2009/03/30 01:08:46, 2, class=passdb] init_group_from_ldap: Entry found for group: 210 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10] LEGACY: sid S-1-5-32-544 -> gid 210 [2009/03/30 01:08:46, 10, class=tdb] Cache entry with key = IDMAP/SID2GID/S-1-5-32-545 couldn't be found [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-32-545))], scope => [2] [2009/03/30 01:08:46, 2, class=passdb] init_group_from_ldap: Entry found for group: 100 [2009/03/30 01:08:46, 10] attribute displayName does not exist [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10] LEGACY: sid S-1-5-32-545 -> gid 100 [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(|(objectclass=sambaGroupMapping)(sambaGroupType=4))(|(sambaSIDList=S-1-5-21-655183313-499555889-1571944852-3000)(sambaSIDList=S-1-1-0)(sambaSIDList=S-1-5-2)(sambaSIDList=S-1-5-11)))], scope => [2] [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(|(objectclass=sambaGroupMapping)(sambaGroupType=4))(|(sambaSIDList=S-1-5-21-655183313-499555889-1571944852-3000)(sambaSIDList=S-1-1-0)(sambaSIDList=S-1-5-2)(sambaSIDList=S-1-5-11)))], scope => [2] [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] get_privileges: No privileges assigned to SID [S-1-5-21-655183313-499555889-1571944852-3000] [2009/03/30 01:08:46, 5] get_privileges_for_sids: sid = S-1-1-0 Privilege set: SE_PRIV 0x0 0x0 0x0 0x0 [2009/03/30 01:08:46, 3] get_privileges: No privileges assigned to SID [S-1-5-2] [2009/03/30 01:08:46, 3] get_privileges: No privileges assigned to SID [S-1-5-11] [2009/03/30 01:08:46, 10, class=tdb] Cache entry with key = IDMAP/SID2GID/S-1-1-0 couldn't be found [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(sambaSID=S-1-1-0))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getgroup: Did not find group, filter was (&(objectClass=sambaGroupMapping)(sambaSID=S-1-1-0)) [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10] LEGACY: mapping failed for sid S-1-1-0 [2009/03/30 01:08:46, 10, class=auth] Could not convert SID S-1-1-0 to gid, ignoring it [2009/03/30 01:08:46, 10, class=tdb] Cache entry with key = IDMAP/SID2GID/S-1-5-2 couldn't be found [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-2))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getgroup: Did not find group, filter was (&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-2)) [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10] LEGACY: mapping failed for sid S-1-5-2 [2009/03/30 01:08:46, 10, class=auth] Could not convert SID S-1-5-2 to gid, ignoring it [2009/03/30 01:08:46, 10, class=tdb] Cache entry with key = IDMAP/SID2GID/S-1-5-11 couldn't be found [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-11))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getgroup: Did not find group, filter was (&(objectClass=sambaGroupMapping)(sambaSID=S-1-5-11)) [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10] LEGACY: mapping failed for sid S-1-5-11 [2009/03/30 01:08:46, 10, class=auth] Could not convert SID S-1-5-11 to gid, ignoring it [2009/03/30 01:08:46, 10] NT user token of user S-1-5-21-655183313-499555889-1571944852-3000 contains 5 SIDs SID[ 0]: S-1-5-21-655183313-499555889-1571944852-3000 SID[ 1]: S-1-1-0 SID[ 2]: S-1-5-2 SID[ 3]: S-1-5-11 SID[ 4]: S-1-22-1-1000 SE_PRIV 0x0 0x0 0x0 0x0 [2009/03/30 01:08:46, 10] UNIX token of user 1000 Primary group is 1000 and contains 0 supplementary groups [2009/03/30 01:08:46, 10] Got NT session key of length 16 [2009/03/30 01:08:46, 10] ntlmssp_server_auth: Created NTLM2 session key. [2009/03/30 01:08:46, 3] NTLMSSP Sign/Seal - Initialising with flags: [2009/03/30 01:08:46, 3] 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 [2009/03/30 01:08:46, 10] register_existing_vuid: (1000,1000) guy guy KORN guest=0 [2009/03/30 01:08:46, 3] register_existing_vuid: User name: guy Real name: Korn András [2009/03/30 01:08:46, 3] register_existing_vuid: UNIX uid 1000 is UNIX user guy, and will be vuid 100 [2009/03/30 01:08:46, 10] Locking key 49442F3100 [2009/03/30 01:08:46, 10] Allocated locked data 0x0xdaadb0 [2009/03/30 01:08:46, 1] Re-using invalid record [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: Init user: guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: setting rhost to: hellgate.intra.guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: setting tty [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: Init passed for user: guy [2009/03/30 01:08:46, 4, class=auth] smb_internal_pam_session: PAM: tty set to: smb/1 [2009/03/30 01:08:46, 4, class=auth] smb_pam_end: PAM: PAM_END OK. [2009/03/30 01:08:46, 10] Unlocking key 49442F3100 [2009/03/30 01:08:46, 2] utmp_update: uname:/var/run/utmp wname:/var/log/wtmp [2009/03/30 01:08:46, 3] Using static (or previously created) service for user 'guy'; path = '/home/guy' [2009/03/30 01:08:46, 3] srv_set_signing: turning on SMB signing: signing negotiated = Yes, mandatory_signing = No. [2009/03/30 01:08:46, 6] lp_file_list_changed() file /etc/samba/smb.conf -> /etc/samba/smb.conf last mod_time: Mon Mar 30 01:08:28 2009 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 0 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 4294967291 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 4294967292 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 4294967293 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 4294967294 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 4294967295 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 0 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 1 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 2 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 3 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 4 [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] size=96 smb_com=0x73 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=31256 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=53 [2009/03/30 01:08:46, 10] [000] A1 07 30 05 A0 03 0A 01 00 55 00 6E 00 69 00 78 ..0..... .U.n.i.x [010] 00 00 00 53 00 61 00 6D 00 62 00 61 00 20 00 33 ...S.a.m .b.a. .3 [020] 00 2E 00 33 00 2E 00 32 00 00 00 4B 00 4F 00 52 ...3...2 ...K.O.R [030] 00 4E 00 00 00 .N... [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 1 [2009/03/30 01:08:46, 10] srv_sign_outgoing_message: seq 1: sent SMB signature of [2009/03/30 01:08:46, 10] [000] E0 35 0A 3E 38 03 37 20 .5.>8.7 [2009/03/30 01:08:46, 10] got smb length of 88 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 2 [2009/03/30 01:08:46, 10] srv_check_incoming_message: seq 2: (current is 4) got good SMB signature of [2009/03/30 01:08:46, 10] [000] 68 F8 FC 94 33 9F 67 3A h...3.g: [2009/03/30 01:08:46, 6] got message type 0x0 of len 0x58 [2009/03/30 01:08:46, 3] Transaction 3 of length 92 (0 toread) [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] size=88 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51205 smb_tid=0 smb_pid=31256 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=45 [2009/03/30 01:08:46, 10] [000] 00 5C 00 5C 00 31 00 39 00 32 00 2E 00 31 00 36 .\.\.1.9 .2...1.6 [010] 00 38 00 2E 00 30 00 2E 00 39 00 39 00 5C 00 49 .8...0.. .9.9.\.I [020] 00 50 00 43 00 24 00 00 00 49 50 43 00 .P.C.$.. .IPC. [2009/03/30 01:08:46, 3] switch message SMBtconX (pid 7114) conn 0x0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_root_user: now uid=(0,0) gid=(0,0) [2009/03/30 01:08:46, 4] Client requested device type [IPC] for share [IPC$] [2009/03/30 01:08:46, 5] making a connection to 'normal' service ipc$ [2009/03/30 01:08:46, 3] check_access: no hostnames in host allow/deny list. [2009/03/30 01:08:46, 2] Allowed connection from (192.168.0.4) [2009/03/30 01:08:46, 10] user_ok_token: share IPC$ is ok for unix user guy [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_username: setting username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_domain: setting domain KORN, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_nt_username: setting nt username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_full_name: setting full name Korn András, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_homedir: setting home dir \\pdc\%u\profile, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_dir_drive: setting dir drive N:, was NULL [2009/03/30 01:08:46, 10, class=passdb] pdb_set_logon_script: setting logon script %u.cmd, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_profile_path: setting profile path , was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_workstations: setting workstations , was [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid_from_rid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 from rid 3000 [2009/03/30 01:08:46, 5] Finding user guy [2009/03/30 01:08:46, 5] Trying _Get_Pwnam(), username as lowercase is guy [2009/03/30 01:08:46, 5] Get_Pwnam_internals did find user [guy]! [2009/03/30 01:08:46, 10] set_conn_connectpath: service IPC$, connectpath = /tmp [2009/03/30 01:08:46, 3] Connect path is '/tmp' for service [IPC$] [2009/03/30 01:08:46, 10] se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2009/03/30 01:08:46, 3, class=vfs] Initialising default vfs hooks [2009/03/30 01:08:46, 10, class=vfs] vfs_find_backend_entry called for /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Successfully added vfs backend '/[Default VFS]/' [2009/03/30 01:08:46, 10, class=vfs] vfs_find_backend_entry called for posixacl [2009/03/30 01:08:46, 5, class=vfs] Successfully added vfs backend 'posixacl' [2009/03/30 01:08:46, 3, class=vfs] Initialising custom vfs hooks from [/[Default VFS]/] [2009/03/30 01:08:46, 10, class=vfs] vfs_find_backend_entry called for /[Default VFS]/ Successfully loaded vfs module [/[Default VFS]/] with the new modules system [2009/03/30 01:08:46, 5, class=vfs] Checking operation #0 (type 0, layer 0) Making operation type 0 opaque [module /[Default VFS]/] Accepting operation type 0 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #1 (type 1, layer 0) Making operation type 1 opaque [module /[Default VFS]/] Accepting operation type 1 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #2 (type 2, layer 0) Making operation type 2 opaque [module /[Default VFS]/] Accepting operation type 2 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #3 (type 3, layer 0) Making operation type 3 opaque [module /[Default VFS]/] Accepting operation type 3 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #4 (type 4, layer 0) Making operation type 4 opaque [module /[Default VFS]/] Accepting operation type 4 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #5 (type 5, layer 0) Making operation type 5 opaque [module /[Default VFS]/] Accepting operation type 5 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #6 (type 6, layer 0) Making operation type 6 opaque [module /[Default VFS]/] Accepting operation type 6 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #7 (type 7, layer 0) Making operation type 7 opaque [module /[Default VFS]/] Accepting operation type 7 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #8 (type 8, layer 0) Making operation type 8 opaque [module /[Default VFS]/] Accepting operation type 8 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #9 (type 9, layer 0) Making operation type 9 opaque [module /[Default VFS]/] Accepting operation type 9 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #10 (type 10, layer 0) Making operation type 10 opaque [module /[Default VFS]/] Accepting operation type 10 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #11 (type 11, layer 0) Making operation type 11 opaque [module /[Default VFS]/] Accepting operation type 11 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #12 (type 12, layer 0) Making operation type 12 opaque [module /[Default VFS]/] Accepting operation type 12 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #13 (type 13, layer 0) Making operation type 13 opaque [module /[Default VFS]/] Accepting operation type 13 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #14 (type 14, layer 0) Making operation type 14 opaque [module /[Default VFS]/] Accepting operation type 14 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #15 (type 15, layer 0) Making operation type 15 opaque [module /[Default VFS]/] Accepting operation type 15 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #16 (type 16, layer 0) Making operation type 16 opaque [module /[Default VFS]/] Accepting operation type 16 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #17 (type 17, layer 0) Making operation type 17 opaque [module /[Default VFS]/] Accepting operation type 17 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #18 (type 18, layer 0) Making operation type 18 opaque [module /[Default VFS]/] Accepting operation type 18 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #19 (type 19, layer 0) Making operation type 19 opaque [module /[Default VFS]/] Accepting operation type 19 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #20 (type 20, layer 0) Making operation type 20 opaque [module /[Default VFS]/] Accepting operation type 20 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #21 (type 21, layer 0) Making operation type 21 opaque [module /[Default VFS]/] Accepting operation type 21 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #22 (type 22, layer 0) Making operation type 22 opaque [module /[Default VFS]/] Accepting operation type 22 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #23 (type 23, layer 0) Making operation type 23 opaque [module /[Default VFS]/] Accepting operation type 23 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #24 (type 24, layer 0) Making operation type 24 opaque [module /[Default VFS]/] Accepting operation type 24 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #25 (type 25, layer 0) Making operation type 25 opaque [module /[Default VFS]/] Accepting operation type 25 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #26 (type 26, layer 0) Making operation type 26 opaque [module /[Default VFS]/] Accepting operation type 26 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #27 (type 27, layer 0) Making operation type 27 opaque [module /[Default VFS]/] Accepting operation type 27 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #28 (type 28, layer 0) Making operation type 28 opaque [module /[Default VFS]/] Accepting operation type 28 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #29 (type 29, layer 0) Making operation type 29 opaque [module /[Default VFS]/] Accepting operation type 29 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #30 (type 30, layer 0) Making operation type 30 opaque [module /[Default VFS]/] Accepting operation type 30 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #31 (type 31, layer 0) Making operation type 31 opaque [module /[Default VFS]/] Accepting operation type 31 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #32 (type 32, layer 0) Making operation type 32 opaque [module /[Default VFS]/] Accepting operation type 32 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #33 (type 33, layer 0) Making operation type 33 opaque [module /[Default VFS]/] Accepting operation type 33 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #34 (type 34, layer 0) Making operation type 34 opaque [module /[Default VFS]/] Accepting operation type 34 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #35 (type 35, layer 0) Making operation type 35 opaque [module /[Default VFS]/] Accepting operation type 35 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #36 (type 36, layer 0) Making operation type 36 opaque [module /[Default VFS]/] Accepting operation type 36 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #37 (type 37, layer 0) Making operation type 37 opaque [module /[Default VFS]/] Accepting operation type 37 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #38 (type 38, layer 0) Making operation type 38 opaque [module /[Default VFS]/] Accepting operation type 38 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #39 (type 39, layer 0) Making operation type 39 opaque [module /[Default VFS]/] Accepting operation type 39 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #40 (type 40, layer 0) Making operation type 40 opaque [module /[Default VFS]/] Accepting operation type 40 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #41 (type 41, layer 0) Making operation type 41 opaque [module /[Default VFS]/] Accepting operation type 41 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #42 (type 42, layer 0) Making operation type 42 opaque [module /[Default VFS]/] Accepting operation type 42 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #43 (type 43, layer 0) Making operation type 43 opaque [module /[Default VFS]/] Accepting operation type 43 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #44 (type 44, layer 0) Making operation type 44 opaque [module /[Default VFS]/] Accepting operation type 44 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #45 (type 45, layer 0) Making operation type 45 opaque [module /[Default VFS]/] Accepting operation type 45 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #46 (type 46, layer 0) Making operation type 46 opaque [module /[Default VFS]/] Accepting operation type 46 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #47 (type 47, layer 0) Making operation type 47 opaque [module /[Default VFS]/] Accepting operation type 47 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #48 (type 48, layer 0) Making operation type 48 opaque [module /[Default VFS]/] Accepting operation type 48 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #49 (type 49, layer 0) Making operation type 49 opaque [module /[Default VFS]/] Accepting operation type 49 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #50 (type 50, layer 0) Making operation type 50 opaque [module /[Default VFS]/] Accepting operation type 50 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #51 (type 51, layer 0) Making operation type 51 opaque [module /[Default VFS]/] Accepting operation type 51 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #52 (type 52, layer 0) Making operation type 52 opaque [module /[Default VFS]/] Accepting operation type 52 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #53 (type 53, layer 0) Making operation type 53 opaque [module /[Default VFS]/] Accepting operation type 53 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #54 (type 54, layer 0) Making operation type 54 opaque [module /[Default VFS]/] Accepting operation type 54 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #55 (type 55, layer 0) Making operation type 55 opaque [module /[Default VFS]/] Accepting operation type 55 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #56 (type 56, layer 0) Making operation type 56 opaque [module /[Default VFS]/] Accepting operation type 56 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #57 (type 57, layer 0) Making operation type 57 opaque [module /[Default VFS]/] Accepting operation type 57 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #58 (type 58, layer 0) Making operation type 58 opaque [module /[Default VFS]/] Accepting operation type 58 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #59 (type 59, layer 0) Making operation type 59 opaque [module /[Default VFS]/] Accepting operation type 59 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #60 (type 60, layer 0) Making operation type 60 opaque [module /[Default VFS]/] Accepting operation type 60 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #61 (type 61, layer 0) Making operation type 61 opaque [module /[Default VFS]/] Accepting operation type 61 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #62 (type 62, layer 0) Making operation type 62 opaque [module /[Default VFS]/] Accepting operation type 62 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #63 (type 63, layer 0) Making operation type 63 opaque [module /[Default VFS]/] Accepting operation type 63 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #64 (type 64, layer 0) Making operation type 64 opaque [module /[Default VFS]/] Accepting operation type 64 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #65 (type 65, layer 0) Making operation type 65 opaque [module /[Default VFS]/] Accepting operation type 65 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #66 (type 66, layer 0) Making operation type 66 opaque [module /[Default VFS]/] Accepting operation type 66 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #67 (type 67, layer 0) Making operation type 67 opaque [module /[Default VFS]/] Accepting operation type 67 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #68 (type 68, layer 0) Making operation type 68 opaque [module /[Default VFS]/] Accepting operation type 68 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #69 (type 69, layer 0) Making operation type 69 opaque [module /[Default VFS]/] Accepting operation type 69 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #70 (type 70, layer 0) Making operation type 70 opaque [module /[Default VFS]/] Accepting operation type 70 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #71 (type 71, layer 0) Making operation type 71 opaque [module /[Default VFS]/] Accepting operation type 71 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #72 (type 72, layer 0) Making operation type 72 opaque [module /[Default VFS]/] Accepting operation type 72 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #73 (type 73, layer 0) Making operation type 73 opaque [module /[Default VFS]/] Accepting operation type 73 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #74 (type 74, layer 0) Making operation type 74 opaque [module /[Default VFS]/] Accepting operation type 74 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #75 (type 75, layer 0) Making operation type 75 opaque [module /[Default VFS]/] Accepting operation type 75 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #76 (type 76, layer 0) Making operation type 76 opaque [module /[Default VFS]/] Accepting operation type 76 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #77 (type 77, layer 0) Making operation type 77 opaque [module /[Default VFS]/] Accepting operation type 77 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #78 (type 78, layer 0) Making operation type 78 opaque [module /[Default VFS]/] Accepting operation type 78 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #79 (type 79, layer 0) Making operation type 79 opaque [module /[Default VFS]/] Accepting operation type 79 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #80 (type 80, layer 0) Making operation type 80 opaque [module /[Default VFS]/] Accepting operation type 80 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #81 (type 81, layer 0) Making operation type 81 opaque [module /[Default VFS]/] Accepting operation type 81 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #82 (type 82, layer 0) Making operation type 82 opaque [module /[Default VFS]/] Accepting operation type 82 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #83 (type 83, layer 0) Making operation type 83 opaque [module /[Default VFS]/] Accepting operation type 83 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #84 (type 84, layer 0) Making operation type 84 opaque [module /[Default VFS]/] Accepting operation type 84 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #85 (type 85, layer 0) Making operation type 85 opaque [module /[Default VFS]/] Accepting operation type 85 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #86 (type 86, layer 0) Making operation type 86 opaque [module /[Default VFS]/] Accepting operation type 86 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #87 (type 87, layer 0) Making operation type 87 opaque [module /[Default VFS]/] Accepting operation type 87 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #88 (type 88, layer 0) Making operation type 88 opaque [module /[Default VFS]/] Accepting operation type 88 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #89 (type 89, layer 0) Making operation type 89 opaque [module /[Default VFS]/] Accepting operation type 89 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #90 (type 90, layer 0) Making operation type 90 opaque [module /[Default VFS]/] Accepting operation type 90 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #91 (type 91, layer 0) Making operation type 91 opaque [module /[Default VFS]/] Accepting operation type 91 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #92 (type 92, layer 0) Making operation type 92 opaque [module /[Default VFS]/] Accepting operation type 92 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #93 (type 93, layer 0) Making operation type 93 opaque [module /[Default VFS]/] Accepting operation type 93 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #94 (type 94, layer 0) Making operation type 94 opaque [module /[Default VFS]/] Accepting operation type 94 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #95 (type 95, layer 0) Making operation type 95 opaque [module /[Default VFS]/] Accepting operation type 95 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #96 (type 96, layer 0) Making operation type 96 opaque [module /[Default VFS]/] Accepting operation type 96 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #97 (type 97, layer 0) Making operation type 97 opaque [module /[Default VFS]/] Accepting operation type 97 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #98 (type 98, layer 0) Making operation type 98 opaque [module /[Default VFS]/] Accepting operation type 98 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #99 (type 99, layer 0) Making operation type 99 opaque [module /[Default VFS]/] Accepting operation type 99 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #100 (type 100, layer 0) Making operation type 100 opaque [module /[Default VFS]/] Accepting operation type 100 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #101 (type 101, layer 0) Making operation type 101 opaque [module /[Default VFS]/] Accepting operation type 101 from module /[Default VFS]/ [2009/03/30 01:08:46, 5, class=vfs] Checking operation #102 (type 102, layer 0) Making operation type 102 opaque [module /[Default VFS]/] Accepting operation type 102 from module /[Default VFS]/ [2009/03/30 01:08:46, 5] claiming [IPC$] [2009/03/30 01:08:46, 10] Locking key CA1B0000FFFFFFFF0100 [2009/03/30 01:08:46, 10] Allocated locked data 0x0xde9520 [2009/03/30 01:08:46, 10] Unlocking key CA1B0000FFFFFFFF0100 [2009/03/30 01:08:46, 10] user_ok_token: share IPC$ is ok for unix user guy [2009/03/30 01:08:46, 10] is_share_read_only_for_user: share IPC$ is read-only for unix user guy [2009/03/30 01:08:46, 10] se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2009/03/30 01:08:46, 3] string_to_sid: Sid root does not start with 'S-'. [2009/03/30 01:08:46, 10] lookup_name: KORN\root => KORN (domain), root (name) [2009/03/30 01:08:46, 10] lookup_name: flags = 0x073 [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [dc=intra,dc=guy], filter => [(&(uid=root)(objectclass=sambaSamAccount))], scope => [2] [2009/03/30 01:08:46, 2, class=passdb] init_sam_from_ldap: Entry found for user: root [2009/03/30 01:08:46, 10, class=passdb] pdb_set_username: setting username root, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_domain: setting domain KORN, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_nt_username: setting nt username root, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid_from_string: setting user sid S-1-5-21-655183313-499555889-1571944852-500 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid: setting user sid S-1-5-21-655183313-499555889-1571944852-500 [2009/03/30 01:08:46, 10] attribute displayName does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_full_name: setting full name root, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_dir_drive: setting dir drive N:, was NULL [2009/03/30 01:08:46, 10] attribute sambaHomePath does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_homedir: setting home dir \\pdc\%u\profile, was [2009/03/30 01:08:46, 10] attribute sambaLogonScript does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_logon_script: setting logon script %u.cmd, was [2009/03/30 01:08:46, 10] attribute sambaProfilePath does not exist [2009/03/30 01:08:46, 10, class=passdb] pdb_set_profile_path: setting profile path , was [2009/03/30 01:08:46, 10] attribute description does not exist [2009/03/30 01:08:46, 10] attribute sambaUserWorkstations does not exist [2009/03/30 01:08:46, 10] attribute sambaMungedDial does not exist [2009/03/30 01:08:46, 10] attribute sambaLMPassword does not exist [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 10] attribute sambaBadPasswordCount does not exist [2009/03/30 01:08:46, 10] attribute sambaBadPasswordTime does not exist [2009/03/30 01:08:46, 10] attribute sambaLogonHours does not exist [2009/03/30 01:08:46, 7, class=passdb] Looking up login cache for user root [2009/03/30 01:08:46, 7, class=passdb] No cache entry found [2009/03/30 01:08:46, 9, class=passdb] No cache entry, bad count = 0, bad time = 0 [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning expired cache entry: key = ACCT_POL/maximum password age, value = 4294967295 , timeout = Mon Mar 30 00:52:25 2009 [2009/03/30 01:08:46, 10, class=passdb] ldapsam_get_account_policy_from_ldap [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [sambaDomainName=KORN,dc=intra,dc=guy], filter => [(objectclass=*)], scope => [0] [2009/03/30 01:08:46, 10] cache_account_policy_set: updating account pol cache [2009/03/30 01:08:46, 10, class=tdb] Adding cache entry with key = ACCT_POL/maximum password age; value = 4294967295 and timeout = Mon Mar 30 01:09:46 2009 (60 seconds ahead) [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] Finding user root [2009/03/30 01:08:46, 5] Trying _Get_Pwnam(), username as lowercase is root [2009/03/30 01:08:46, 5] Get_Pwnam_internals did find user [root]! [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(gidNumber=0))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getgroup: Did not find group, filter was (&(objectClass=sambaGroupMapping)(gidNumber=0)) [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_username: setting username root, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_domain: setting domain KORN, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_nt_username: setting nt username root, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_full_name: setting full name root, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_homedir: setting home dir \\pdc\%u\profile, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_dir_drive: setting dir drive N:, was NULL [2009/03/30 01:08:46, 10, class=passdb] pdb_set_logon_script: setting logon script %u.cmd, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_profile_path: setting profile path , was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_workstations: setting workstations , was [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 2 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid: setting user sid S-1-5-21-655183313-499555889-1571944852-500 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid_from_rid: setting user sid S-1-5-21-655183313-499555889-1571944852-500 from rid 500 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] string_to_sid: Sid Administrator does not start with 'S-'. [2009/03/30 01:08:46, 10] lookup_name: KORN\Administrator => KORN (domain), Administrator (name) [2009/03/30 01:08:46, 10] lookup_name: flags = 0x073 [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [dc=intra,dc=guy], filter => [(&(uid=Administrator)(objectclass=sambaSamAccount))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getsampwnam: Unable to locate user [Administrator] count=0 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(|(displayName=Administrator)(cn=Administrator)))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getgroup: Did not find group, filter was (&(objectClass=sambaGroupMapping)(|(displayName=Administrator)(cn=Administrator))) [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10] lookup_name: Unix User\Administrator => Unix User (domain), Administrator (name) [2009/03/30 01:08:46, 10] lookup_name: flags = 0x073 [2009/03/30 01:08:46, 5] lookup_name Administrator failed [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_username: setting username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_domain: setting domain KORN, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_nt_username: setting nt username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_full_name: setting full name Korn András, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_homedir: setting home dir \\pdc\%u\profile, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_dir_drive: setting dir drive N:, was NULL [2009/03/30 01:08:46, 10, class=passdb] pdb_set_logon_script: setting logon script %u.cmd, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_profile_path: setting profile path , was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_workstations: setting workstations , was [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid_from_rid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 from rid 3000 [2009/03/30 01:08:46, 3] setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token of user S-1-5-21-655183313-499555889-1571944852-3000 contains 5 SIDs SID[ 0]: S-1-5-21-655183313-499555889-1571944852-3000 SID[ 1]: S-1-1-0 SID[ 2]: S-1-5-2 SID[ 3]: S-1-5-11 SID[ 4]: S-1-22-1-1000 SE_PRIV 0x0 0x0 0x0 0x0 [2009/03/30 01:08:46, 5] UNIX token of user 1000 Primary group is 1000 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_user uid=(0,1000) gid=(0,1000) [2009/03/30 01:08:46, 3] hellgate (192.168.0.4) signed connect to service IPC$ initially as user guy (uid=1000, gid=1000) (pid 7114) [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_root_user: now uid=(0,0) gid=(0,0) [2009/03/30 01:08:46, 3] tconX service=IPC$ [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] size=56 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=136 smb_flg2=51201 smb_tid=1 smb_pid=31256 smb_uid=100 smb_mid=4 smt_wct=7 smb_vwv[ 0]= 255 (0xFF) smb_vwv[ 1]= 0 (0x0) smb_vwv[ 2]= 1 (0x1) smb_vwv[ 3]= 511 (0x1FF) smb_vwv[ 4]= 0 (0x0) smb_vwv[ 5]= 511 (0x1FF) smb_vwv[ 6]= 0 (0x0) smb_bcc=7 [2009/03/30 01:08:46, 10] [000] 49 50 43 00 00 00 00 IPC.... [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 3 [2009/03/30 01:08:46, 10] srv_sign_outgoing_message: seq 3: sent SMB signature of [2009/03/30 01:08:46, 10] [000] 1B 1C 98 4A 92 DA D3 F4 ...J.... [2009/03/30 01:08:46, 10] got smb length of 110 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 4 [2009/03/30 01:08:46, 10] srv_check_incoming_message: seq 4: (current is 6) got good SMB signature of [2009/03/30 01:08:46, 10] [000] FC 72 49 A1 03 42 C4 4D .rI..B.M [2009/03/30 01:08:46, 6] got message type 0x0 of len 0x6e [2009/03/30 01:08:46, 3] Transaction 4 of length 114 (0 toread) [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] size=110 smb_com=0x32 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51205 smb_tid=1 smb_pid=31256 smb_uid=100 smb_mid=5 smt_wct=15 smb_vwv[ 0]= 42 (0x2A) 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]= 42 (0x2A) smb_vwv[10]= 68 (0x44) smb_vwv[11]= 0 (0x0) smb_vwv[12]= 110 (0x6E) smb_vwv[13]= 1 (0x1) smb_vwv[14]= 16 (0x10) smb_bcc=45 [2009/03/30 01:08:46, 10] [000] 00 44 20 03 00 5C 00 31 00 39 00 32 00 2E 00 31 .D ..\.1 .9.2...1 [010] 00 36 00 38 00 2E 00 30 00 2E 00 39 00 39 00 5C .6.8...0 ...9.9.\ [020] 00 73 00 74 00 6F 00 72 00 65 00 00 00 .s.t.o.r .e... [2009/03/30 01:08:46, 3] switch message SMBtrans2 (pid 7114) conn 0xdea1a0 [2009/03/30 01:08:46, 3] setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token of user S-1-5-21-655183313-499555889-1571944852-3000 contains 5 SIDs SID[ 0]: S-1-5-21-655183313-499555889-1571944852-3000 SID[ 1]: S-1-1-0 SID[ 2]: S-1-5-2 SID[ 3]: S-1-5-11 SID[ 4]: S-1-22-1-1000 SE_PRIV 0x0 0x0 0x0 0x0 [2009/03/30 01:08:46, 5] UNIX token of user 1000 Primary group is 1000 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_user uid=(0,1000) gid=(0,1000) [2009/03/30 01:08:46, 4, class=vfs] vfs_ChDir to /tmp [2009/03/30 01:08:46, 10] call_trans2getdfsreferral [2009/03/30 01:08:46, 10, class=msdfs] parse_dfs_path: temp = |192.168.0.99\store| after trimming \'s [2009/03/30 01:08:46, 10, class=msdfs] parse_dfs_path: hostname: 192.168.0.99 [2009/03/30 01:08:46, 10, class=msdfs] parse_dfs_path: servicename: store [2009/03/30 01:08:46, 3, class=msdfs] get_referred_path: |store| in dfs path \192.168.0.99\store is not a dfs root. [2009/03/30 01:08:46, 3] error packet at smbd/trans2.c(7299) cmd=50 (SMBtrans2) NT_STATUS_NOT_FOUND [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] 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=31256 smb_uid=100 smb_mid=5 smt_wct=0 smb_bcc=0 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 5 [2009/03/30 01:08:46, 10] srv_sign_outgoing_message: seq 5: sent SMB signature of [2009/03/30 01:08:46, 10] [000] 50 E5 42 C2 52 D1 1D 4B P.B.R..K [2009/03/30 01:08:46, 10] got smb length of 35 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 6 [2009/03/30 01:08:46, 10] srv_check_incoming_message: seq 6: (current is 8) got good SMB signature of [2009/03/30 01:08:46, 10] [000] 9C 97 D6 58 D0 C8 16 73 ...X...s [2009/03/30 01:08:46, 6] got message type 0x0 of len 0x23 [2009/03/30 01:08:46, 3] Transaction 5 of length 39 (0 toread) [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] size=35 smb_com=0x71 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51205 smb_tid=1 smb_pid=31256 smb_uid=100 smb_mid=6 smt_wct=0 smb_bcc=0 [2009/03/30 01:08:46, 3] switch message SMBtdis (pid 7114) conn 0xdea1a0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_root_user: now uid=(0,0) gid=(0,0) [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_root_user: now uid=(0,0) gid=(0,0) [2009/03/30 01:08:46, 3] hellgate (192.168.0.4) closed connection to service IPC$ [2009/03/30 01:08:46, 3] Yielding connection to IPC$ [2009/03/30 01:08:46, 10] Locking key CA1B0000FFFFFFFF0100 [2009/03/30 01:08:46, 10] Allocated locked data 0x0xda64f0 [2009/03/30 01:08:46, 10] Unlocking key CA1B0000FFFFFFFF0100 [2009/03/30 01:08:46, 4, class=vfs] vfs_ChDir to / [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_root_user: now uid=(0,0) gid=(0,0) [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] 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=31256 smb_uid=100 smb_mid=6 smt_wct=0 smb_bcc=0 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 7 [2009/03/30 01:08:46, 10] srv_sign_outgoing_message: seq 7: sent SMB signature of [2009/03/30 01:08:46, 10] [000] B7 85 01 7F BF 39 FA 74 .....9.t [2009/03/30 01:08:46, 10] got smb length of 92 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 8 [2009/03/30 01:08:46, 10] srv_check_incoming_message: seq 8: (current is 10) got good SMB signature of [2009/03/30 01:08:46, 10] [000] 4E 0B 00 FC 1B 04 93 6D N......m [2009/03/30 01:08:46, 6] got message type 0x0 of len 0x5c [2009/03/30 01:08:46, 3] Transaction 6 of length 96 (0 toread) [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] size=92 smb_com=0x75 smb_rcls=0 smb_reh=0 smb_err=0 smb_flg=8 smb_flg2=51205 smb_tid=0 smb_pid=31256 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=49 [2009/03/30 01:08:46, 10] [000] 00 5C 00 5C 00 31 00 39 00 32 00 2E 00 31 00 36 .\.\.1.9 .2...1.6 [010] 00 38 00 2E 00 30 00 2E 00 39 00 39 00 5C 00 53 .8...0.. .9.9.\.S [020] 00 54 00 4F 00 52 00 45 00 00 00 3F 3F 3F 3F 3F .T.O.R.E ...????? [030] 00 . [2009/03/30 01:08:46, 3] switch message SMBtconX (pid 7114) conn 0x0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_root_user: now uid=(0,0) gid=(0,0) [2009/03/30 01:08:46, 4] Client requested device type [?????] for share [STORE] [2009/03/30 01:08:46, 5] making a connection to 'normal' service store [2009/03/30 01:08:46, 3] check_access: no hostnames in host allow/deny list. [2009/03/30 01:08:46, 2] Allowed connection from (192.168.0.4) [2009/03/30 01:08:46, 10] user_ok_token: share store is ok for unix user guy [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_username: setting username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_domain: setting domain KORN, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_nt_username: setting nt username guy, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_full_name: setting full name Korn András, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_homedir: setting home dir \\pdc\%u\profile, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_dir_drive: setting dir drive N:, was NULL [2009/03/30 01:08:46, 10, class=passdb] pdb_set_logon_script: setting logon script %u.cmd, was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_profile_path: setting profile path , was [2009/03/30 01:08:46, 10, class=passdb] pdb_set_workstations: setting workstations , was [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 10, class=tdb] Returning valid cache entry: key = ACCT_POL/password history, value = 0 , timeout = Mon Mar 30 01:09:40 2009 [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 [2009/03/30 01:08:46, 10, class=passdb] pdb_set_user_sid_from_rid: setting user sid S-1-5-21-655183313-499555889-1571944852-3000 from rid 3000 [2009/03/30 01:08:46, 5] Finding user guy [2009/03/30 01:08:46, 5] Trying _Get_Pwnam(), username as lowercase is guy [2009/03/30 01:08:46, 5] Get_Pwnam_internals did find user [guy]! [2009/03/30 01:08:46, 10] lookup_name: KORN\guy => KORN (domain), guy (name) [2009/03/30 01:08:46, 10] lookup_name: flags = 0x077 [2009/03/30 01:08:46, 3] push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 3] push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] smbldap_search_ext: base => [ou=Group,dc=intra,dc=guy], filter => [(&(objectClass=sambaGroupMapping)(|(displayName=guy)(cn=guy)))], scope => [2] [2009/03/30 01:08:46, 4, class=passdb] ldapsam_getgroup: Did not find group, filter was (&(objectClass=sambaGroupMapping)(|(displayName=guy)(cn=guy))) [2009/03/30 01:08:46, 3] pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 10] lookup_name: Unix Group\guy => Unix Group (domain), guy (name) [2009/03/30 01:08:46, 10] lookup_name: flags = 0x077 [2009/03/30 01:08:46, 10] sid S-1-22-2-1000 -> gid 1000 [2009/03/30 01:08:46, 3] Forced group guy [2009/03/30 01:08:46, 10] set_conn_connectpath: service store, connectpath = /store [2009/03/30 01:08:46, 3] Connect path is '/store' for service [store] [2009/03/30 01:08:46, 10] se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2009/03/30 01:08:46, 10] se_map_generic(): mapped mask 0x10000000 to 0x001f01ff [2009/03/30 01:08:46, 0] make_connection: connection to store denied due to security descriptor. [2009/03/30 01:08:46, 3] error packet at smbd/reply.c(724) cmd=117 (SMBtconX) NT_STATUS_ACCESS_DENIED [2009/03/30 01:08:46, 5] [2009/03/30 01:08:46, 5] size=35 smb_com=0x75 smb_rcls=34 smb_reh=0 smb_err=49152 smb_flg=136 smb_flg2=51201 smb_tid=0 smb_pid=31256 smb_uid=100 smb_mid=7 smt_wct=0 smb_bcc=0 [2009/03/30 01:08:46, 10] simple_packet_signature: sequence number 9 [2009/03/30 01:08:46, 10] srv_sign_outgoing_message: seq 9: sent SMB signature of [2009/03/30 01:08:46, 10] [000] 50 31 72 39 23 3A 20 B5 P1r9#: . [2009/03/30 01:08:46, 5] read_socket_with_timeout: blocking read. EOF from client. [2009/03/30 01:08:46, 10] receive_smb_raw: NT_STATUS_END_OF_FILE [2009/03/30 01:08:46, 3] receive_message_or_smb failed: NT_STATUS_END_OF_FILE, exiting [2009/03/30 01:08:46, 5, class=tdb] Closing cache file [2009/03/30 01:08:46, 5] namecache_shutdown: netbios namecache closed successfully. [2009/03/30 01:08:46, 3] setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 [2009/03/30 01:08:46, 5] NT user token: (NULL) [2009/03/30 01:08:46, 5] UNIX token of user 0 Primary group is 0 and contains 0 supplementary groups [2009/03/30 01:08:46, 5] change_to_root_user: now uid=(0,0) gid=(0,0) [2009/03/30 01:08:46, 10] Locking key 49442F3100 [2009/03/30 01:08:46, 10] Allocated locked data 0x0xd85ca0 [2009/03/30 01:08:46, 2] utmp_update: uname:/var/run/utmp wname:/var/log/wtmp [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: Init user: guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: setting rhost to: hellgate.intra.guy [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: setting tty [2009/03/30 01:08:46, 4, class=auth] smb_pam_start: PAM: Init passed for user: guy [2009/03/30 01:08:46, 4, class=auth] smb_internal_pam_session: PAM: tty set to: smb/1 [2009/03/30 01:08:46, 4, class=auth] smb_pam_end: PAM: PAM_END OK. [2009/03/30 01:08:46, 10] Unlocking key 49442F3100 [2009/03/30 01:08:46, 3] Yielding connection to [2009/03/30 01:08:46, 10] Locking key CA1B0000FFFFFFFFFFFF [2009/03/30 01:08:46, 10] Allocated locked data 0x0xdea1a0 [2009/03/30 01:08:46, 10] Unlocking key CA1B0000FFFFFFFFFFFF [2009/03/30 01:08:46, 3] Server exit (normal exit)