Jump to content
Welcome to our new Citrix community!
  • 0

VDA 1903 - 1 Minute Hang During Logon


Bertug Demir1709155795

Question

Hello everyone,

 

I've been having logon times far from optimal for a while now. I wanted to check into it and enabled all sorts of logging through Studio Policies. There's a weird delay between 30 to 60 seconds with no information specified in the log file. You may find haphazard occurrences of delay for two different logon attempts in two outputs below;

 

2019-08-25;18:51:42.189;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups>
2019-08-25;18:51:42.204;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups\MicrosoftEdgeBackup20190821>
2019-08-25;18:51:42.225;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups\MicrosoftEdgeBackup20190821\DatastoreBackup>
2019-08-25;18:51:42.251;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups\MicrosoftEdgeBackup20190821\FavoriteIcons>
2019-08-25;18:51:42.269;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups\MicrosoftEdgeBackup20190821\Protected - It is a violation of Windows Policy to modify>
2019-08-25;18:51:42.288;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents>
2019-08-25;18:51:42.299;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents\Micro Focus>
2019-08-25;18:51:42.312;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents\Micro Focus\Net Express 5.1>
2019-08-25;18:51:42.327;INFORMATION;ISBANK;100014;1;668;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents\Micro Focus\Net Express 5.1\WORKAREA>
2019-08-25;18:52:34.074;INFORMATION;ISBANK;100014;1;668;StartJitSupport: Starting streamed profile support thread.

2019-08-25;18:52:34.074;INFORMATION;ISBANK;100014;1;668;ProcessLogon: User logging on with Streamed Profile support enabled.
2019-08-25;18:52:34.074;INFORMATION;ISBANK;100014;1;668;ProcessLogon: Restore finished.
2019-08-25;18:52:34.103;INFORMATION;ISBANK;100014;1;668;CopyFileWithRetries: Copied a file from: <C:\Users\100014\NTUSER.DAT> to <C:\Users\100014\NTUSER.DAT.START>.
2019-08-25;18:52:34.103;INFORMATION;ISBANK;100014;1;668;ImpersonateClientStop: Successfully stopped client impersonation.
2019-08-25;18:52:34.182;INFORMATION;ISBANK;100014;1;668;CopyFileWithRetries: Copied a file from: <C:\Users\100014\NTUSER.DAT.START> to <C:\Users\100014\NTUSER.DAT.BAK>.
2019-08-25;18:52:34.285;INFORMATION;ISBANK;100014;1;668;CRegistryHive::Load: RegLoadKey of <C:\Users\100014\NTUSER.DAT> to <S-1-5-21-1639082044-105522085-4547331-180714> succeeded.
2019-08-25;18:52:34.318;INFORMATION;ISBANK;100014;1;668;CopyFileWithRetries: Copied a file from: <C:\Users\100014\NTUSER.DAT.BAK> to <C:\Users\100014\NTUSER.DAT.BAK.LASTGOODLOAD>.
2019-08-25;18:52:34.319;INFORMATION;ISBANK;100014;1;668;ImpersonateClientStart: Successfully impersonated a client.

 

 

2019-08-25;18:35:05.054;INFORMATION;ISBANK;100014;1;2312;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups\MicrosoftEdgeBackup20190821\DatastoreBackup>
2019-08-25;18:35:05.081;INFORMATION;ISBANK;100014;1;2312;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups\MicrosoftEdgeBackup20190821\FavoriteIcons>
2019-08-25;18:35:05.102;INFORMATION;ISBANK;100014;1;2312;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\MicrosoftEdgeBackups\backups\MicrosoftEdgeBackup20190821\Protected - It is a violation of Windows Policy to modify>
2019-08-25;18:35:05.122;INFORMATION;ISBANK;100014;1;2312;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents>
2019-08-25;18:35:05.136;INFORMATION;ISBANK;100014;1;2312;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents\Micro Focus>
2019-08-25;18:35:05.152;INFORMATION;ISBANK;100014;1;2312;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents\Micro Focus\Net Express 5.1>
2019-08-25;18:35:05.169;INFORMATION;ISBANK;100014;1;2312;CreateDirectoryAPIWrapper: Created the directory: <C:\Users\100014\My Documents\Micro Focus\Net Express 5.1\WORKAREA>
2019-08-25;18:35:32.355;INFORMATION;ISBANK;100014;1;2188;CJitFolderSupport::CacheFillFile: request for <AppData\Roaming\Microsoft\Internet Explorer\Quick Launch\desktop.ini> succeeded.

2019-08-25;18:35:32.754;INFORMATION;ISBANK;100014;1;2188;CJitFolderSupport::CacheFillFile: request for <AppData\Roaming\Microsoft\Windows\AccountPictures\desktop.ini> succeeded.
2019-08-25;18:35:32.816;INFORMATION;ISBANK;100014;1;2188;CJitFolderSupport::CacheFillFile: request for <AppData\Roaming\Microsoft\Windows\Libraries\desktop.ini> succeeded.
2019-08-25;18:35:32.864;INFORMATION;ISBANK;100014;1;2188;CJitFolderSupport::CacheFillFile: request for <AppData\Roaming\Microsoft\Windows\SendTo\Desktop.ini> succeeded.
2019-08-25;18:36:01.253;INFORMATION;ISBANK;100014;1;2188;CJitFolderSupport::CacheFillFile: request for <AppData\Roaming\Microsoft\Internet Explorer\Quick Launch\User Pinned\TaskBar\desktop.ini> succeeded.

2019-08-25;18:36:03.071;INFORMATION;ISBANK;100014;1;2312;StartJitSupport: Starting streamed profile support thread.
2019-08-25;18:36:03.071;INFORMATION;ISBANK;100014;1;2312;ProcessLogon: User logging on with Streamed Profile support enabled.
2019-08-25;18:36:03.071;INFORMATION;ISBANK;100014;1;2312;ProcessLogon: Restore finished.
2019-08-25;18:36:03.097;INFORMATION;ISBANK;100014;1;2312;CopyFileWithRetries: Copied a file from: <C:\Users\100014\NTUSER.DAT> to <C:\Users\100014\NTUSER.DAT.START>.

 

Do you guys have any idea what could be wrong here?

Link to comment

3 answers to this question

Recommended Posts

  • 0

Hi There,

 

Are you using Server OS VDA or Desktop OS VDA?

 

If it is Server OS then there is something you can try, it helped me on similar issue:

- RDP into the Server before reproducing the issue

- Open Resource monitor and go to Disk tab

- In the process select System, explorer and UPM entries

- Ask a user to login

- Monitor where are things stuck when the 30-60 seconds delay is encountered.

- If you are able to bottle-neck it to an app or a folder. try to excluding it via UPM policy and try now

 

Hope it helps.

 

Cheers,

Aseem

Link to comment

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
×
×
  • Create New...