We have a couple of server 2003 terminal servers and they have been working fine for a couple of months up until now. The time it takes to fully logoff after hitting logoff is somewhere around 8 minutes. I have enabled the userenv.log to see if that could help to solve why its hanging.
This is the output:
USERENV(c18.a54) 14:17:32:260 LibMain: Process Name: C:\WINDOWS\system32\userinit.exe
USERENV(c18.a54) 14:17:32:323 GetProfileType: Profile already loaded.
USERENV(c18.a54) 14:17:32:338 GetProfileType: ProfileFlags is 0
USERENV(10c.e00) 14:25:32:551 UnloadUserProfile: Entering, hProfile = <0x2e8>
USERENV(10c.e00) 14:25:32:567 UnloadUserProfile: no thread token found, impersonating self.
USERENV(10c.e00) 14:25:32:567 GetInterface: Returning rpc binding handle
USERENV(178.9e8) 14:25:32:567 IProfileSecurityCallBack: client authenticated.
USERENV(178.9e8) 14:25:32:567 DropClientContext: Got client token 0000097C, sid = S-1-5-18
USERENV(178.9e8) 14:25:32:567 MIDL_user_allocate enter
USERENV(178.9e8) 14:25:32:582 DropClientContext: load profile object successfully made
USERENV(178.9e8) 14:25:32:582 DropClientContext: Returning 0
USERENV(10c.e00) 14:25:32:582 UnLoadUserProfile: Calling DropClientToken (as self) succeeded
USERENV(178.5b8) 14:25:32:582 IProfileSecurityCallBack: client authenticated.
USERENV(178.5b8) 14:25:32:582 UnloadUserProfileP: Entering, hProfile = <0x43c>
USERENV(178.5b8) 14:25:32:598 UnloadUserProfileP: ImpersonateUser <0000097c>, old token is <00000000>
USERENV(178.5b8) 14:25:32:598 GetExclusionListFromRegistry: Policy list is empty, returning user list = <Local Settings;Temporary Internet Files;History;Temp;Local Settings\Application Data\Microsoft\Outlook>
USERENV(178.5b8) 14:25:32:598 CSyncManager::EnterLock <S-1-5-21-354161108-3907344404-1090429810-1112>
USERENV(178.5b8) 14:25:32:598 CSyncManager::EnterLock: No existing entry found
USERENV(178.5b8) 14:25:32:598 CSyncManager::EnterLock: New entry created
USERENV(178.5b8) 14:25:32:613 CHashTable::HashAdd: S-1-5-21-354161108-3907344404-1090429810-1112 added in bucket 12
USERENV(178.5b8) 14:25:32:613 UnloadUserProfileP: Wait succeeded. In critical section.
USERENV(178.5b8) 14:25:32:613 UnloadUserProfileP: Didn't unload user profile, Ref Count is 10
USERENV(178.5b8) 14:25:32:613 UnloadUserProfileP: About Reverted back to user <00000000>
USERENV(178.5b8) 14:25:32:613 CSyncManager::LeaveLock <S-1-5-21-354161108-3907344404-1090429810-1112>
USERENV(178.5b8) 14:25:32:629 CSyncManager::LeaveLock: Lock released
USERENV(178.5b8) 14:25:32:629 CHashTable::HashDelete: S-1-5-21-354161108-3907344404-1090429810-1112 deleted
USERENV(178.5b8) 14:25:32:629 CSyncManager::LeaveLock: Lock deleted
USERENV(178.5b8) 14:25:32:629 UnloadUserProfileP: Leave critical section.
USERENV(178.5b8) 14:25:32:629 UnloadUserProfileP: Leaving with a return value of 1
USERENV(178.5b8) 14:25:32:645 UnloadUserProfileI: returning 0
USERENV(10c.e00) 14:25:32:645 UnloadUserProfile: Calling UnloadUserProfileI succeeded
USERENV(178.9e8) 14:25:32:645 IProfileSecurityCallBack: client authenticated.
USERENV(178.9e8) 14:25:32:645 ReleaseClientContext: Releasing context
USERENV(178.9e8) 14:25:32:645 ReleaseClientContext_s: Releasing context
USERENV(178.9e8) 14:25:32:660 MIDL_user_free enter
USERENV(10c.e00) 14:25:32:660 ReleaseInterface: Releasing rpc binding handle
USERENV(10c.e00) 14:25:32:660 UnloadUserProfile: returning 1
you can see that after 3 lines down is where the 8 minute hang takes place. anyone have any ideas as to why this might be happening?
Thanks,
-drew
This is the output:
USERENV(c18.a54) 14:17:32:260 LibMain: Process Name: C:\WINDOWS\system32\userinit.exe
USERENV(c18.a54) 14:17:32:323 GetProfileType: Profile already loaded.
USERENV(c18.a54) 14:17:32:338 GetProfileType: ProfileFlags is 0
USERENV(10c.e00) 14:25:32:551 UnloadUserProfile: Entering, hProfile = <0x2e8>
USERENV(10c.e00) 14:25:32:567 UnloadUserProfile: no thread token found, impersonating self.
USERENV(10c.e00) 14:25:32:567 GetInterface: Returning rpc binding handle
USERENV(178.9e8) 14:25:32:567 IProfileSecurityCallBack: client authenticated.
USERENV(178.9e8) 14:25:32:567 DropClientContext: Got client token 0000097C, sid = S-1-5-18
USERENV(178.9e8) 14:25:32:567 MIDL_user_allocate enter
USERENV(178.9e8) 14:25:32:582 DropClientContext: load profile object successfully made
USERENV(178.9e8) 14:25:32:582 DropClientContext: Returning 0
USERENV(10c.e00) 14:25:32:582 UnLoadUserProfile: Calling DropClientToken (as self) succeeded
USERENV(178.5b8) 14:25:32:582 IProfileSecurityCallBack: client authenticated.
USERENV(178.5b8) 14:25:32:582 UnloadUserProfileP: Entering, hProfile = <0x43c>
USERENV(178.5b8) 14:25:32:598 UnloadUserProfileP: ImpersonateUser <0000097c>, old token is <00000000>
USERENV(178.5b8) 14:25:32:598 GetExclusionListFromRegistry: Policy list is empty, returning user list = <Local Settings;Temporary Internet Files;History;Temp;Local Settings\Application Data\Microsoft\Outlook>
USERENV(178.5b8) 14:25:32:598 CSyncManager::EnterLock <S-1-5-21-354161108-3907344404-1090429810-1112>
USERENV(178.5b8) 14:25:32:598 CSyncManager::EnterLock: No existing entry found
USERENV(178.5b8) 14:25:32:598 CSyncManager::EnterLock: New entry created
USERENV(178.5b8) 14:25:32:613 CHashTable::HashAdd: S-1-5-21-354161108-3907344404-1090429810-1112 added in bucket 12
USERENV(178.5b8) 14:25:32:613 UnloadUserProfileP: Wait succeeded. In critical section.
USERENV(178.5b8) 14:25:32:613 UnloadUserProfileP: Didn't unload user profile, Ref Count is 10
USERENV(178.5b8) 14:25:32:613 UnloadUserProfileP: About Reverted back to user <00000000>
USERENV(178.5b8) 14:25:32:613 CSyncManager::LeaveLock <S-1-5-21-354161108-3907344404-1090429810-1112>
USERENV(178.5b8) 14:25:32:629 CSyncManager::LeaveLock: Lock released
USERENV(178.5b8) 14:25:32:629 CHashTable::HashDelete: S-1-5-21-354161108-3907344404-1090429810-1112 deleted
USERENV(178.5b8) 14:25:32:629 CSyncManager::LeaveLock: Lock deleted
USERENV(178.5b8) 14:25:32:629 UnloadUserProfileP: Leave critical section.
USERENV(178.5b8) 14:25:32:629 UnloadUserProfileP: Leaving with a return value of 1
USERENV(178.5b8) 14:25:32:645 UnloadUserProfileI: returning 0
USERENV(10c.e00) 14:25:32:645 UnloadUserProfile: Calling UnloadUserProfileI succeeded
USERENV(178.9e8) 14:25:32:645 IProfileSecurityCallBack: client authenticated.
USERENV(178.9e8) 14:25:32:645 ReleaseClientContext: Releasing context
USERENV(178.9e8) 14:25:32:645 ReleaseClientContext_s: Releasing context
USERENV(178.9e8) 14:25:32:660 MIDL_user_free enter
USERENV(10c.e00) 14:25:32:660 ReleaseInterface: Releasing rpc binding handle
USERENV(10c.e00) 14:25:32:660 UnloadUserProfile: returning 1
you can see that after 3 lines down is where the 8 minute hang takes place. anyone have any ideas as to why this might be happening?
Thanks,
-drew