Logon time increased with 15 seconds when using elastic layer function.

[Laurentius Zwanenburg]

We are using AppLayering to create an windows 10 Image for Citrix PVS.

When enabling the elastic layer function, the logon time increase with 15 seconds even when no elastic layer is assigned to the user.

is this a normal behaviour? For us it is not acceptable to increase the logon time with 15 seconds. When assigning elastic layers to the user the logon time is not getting longer then the already 15 seconds.

Is there something we can do to decrease the 15 seconds extra logon time

 

[Rob Zylowski]

It does take longer to log on when using elastic layering even with no layers to attach.  Our service has to go out to the el share and look to see if nay layers need to be mounted.  How long it takes is based on the performance of the desktop and the infrastructure.  There is a log in c:\programdata\unidesk\Logs\ulayersvc.log that will tell you what is happening during logon and how long it takes.

[Laurentius Zwanenburg]

We have upgraded the applayer appliance.

Today i created a new image with elastic layer enabled. And this was much better. It was hard to measure  the difference in logon time. I found the “c:\programdata\unidesk\Logs\ulayersvc.log” and when it happens again I will look there. I am not sure it was the upgrade  that did the trick but for now we can test this feature.

Thanx for the reaction.

[Laurentius Zwanenburg]

The slow logins are still here. I don't know why is works quick for one day.

we also use FSLogix and Ivanti workspace controle.

we have applied the regkey.

HKLM\System\CurrentControlSet\Services\frxdrvvt\Instances\frxdrvvt\Altitude

Set the value to 138010

 

when elastic layer is enabled everything in the login process is slower.

i click the desktop icon and the the welkom screen shows and takes about 3 seconds slower.

I think this is where the FSLogixs disks and elastic layers are mounted.

after that Ivanti workspace control starts, every step takes just a bit longer.

in total the login time increase with 15 to 25 seconds.

 

 

in the logfile i do not see the process to mount the disk is slow.

2022-02-10 14:13:00,312 INFO 19 RequestService: Starting request 1 on behalf of domain\user01
2022-02-10 14:13:00,344 INFO 19 SessionEventHandler: Received logon event
2022-02-10 14:13:00,344 INFO 19 SessionEventHandler: logging in user domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx)
2022-02-10 14:13:00,359 INFO 19 LogonInfoService: User domain\user01 is not a local user
2022-02-10 14:13:00,359 INFO 19 LogonInfoService: User domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx) is an elastic layer user. Elastic layers are enabled.
2022-02-10 14:13:00,359 INFO 19 DynamicLayeringService: Logging in user domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx)
2022-02-10 14:13:00,359 INFO 19 SessionUserRestrictionService: Cleared the restricted user list volumes for sid (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx)
2022-02-10 14:13:00,359 INFO 19 SessionDynamicLayeringService: Running on a session host thus there will be no user layer
2022-02-10 14:13:00,359 INFO 19 CompositingManager: Beginning compositing app layers: user domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx)
2022-02-10 14:13:00,359 INFO 19 WindowsId: Impersonating domain\user01
2022-02-10 14:13:00,703 INFO 19 ElasticLayerDataSource: Compositing phase settings: Default=PostLogon, Max=OnDemand
2022-02-10 14:13:00,750 INFO 19 ElasticLayerOnDemandFilter: Filtering all OnDemand layers
2022-02-10 14:13:00,766 INFO 19 Impersonator: Entering Self impersonation context
2022-02-10 14:13:00,766 INFO 19 WindowsId: Impersonating NT AUTHORITY\SYSTEM
2022-02-10 14:13:00,766 INFO 19 MachineIdentityService: ImageInfo path: C:\Program Files\Unidesk\Etc\ImageInfo.json
2022-02-10 14:13:00,766 INFO 19 MachineIdentityService: ImageInfo path: {"OsLayerId":1966094,"OsLayerGuid":"cfcee9e6-a95a-4bc9-af1b-00c5334263d7","OsLayerName":"Windows 10 x64 MDT"}
2022-02-10 14:13:00,766 INFO 19 MachineIdentityService: ImageInfo: 1966094, Windows 10 x64 MDT
2022-02-10 14:13:00,766 INFO 19 WindowsId: Finished impersonating NT AUTHORITY\SYSTEM
2022-02-10 14:13:00,781 INFO 19 WindowsId: Finished impersonating domain\user01
2022-02-10 14:13:00,781 INFO 19 LayerConfigService: Attaching ElasticLayer: Name 'treesize - el' : FileName 'Unidesk/Layers/App/P39419906.R1.vhd'
2022-02-10 14:13:00,875 INFO 19 SessionUserRestrictionService: Allowing package id 39419906#1 version 1 for sid (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx)
2022-02-10 14:13:00,875 INFO 17 LayerConfigService: Opening app disk '\\c-sofs-p01.zorgmh.local\AppLayer\Unidesk\Layers\App\P39419906.R1.vhd'
2022-02-10 14:13:00,875 INFO 17 WindowsId: Impersonating domain\user01
2022-02-10 14:13:00,891 INFO 19 TaskScheduleService: Task tree key, found 'HKLM\Software\Microsoft\Windows NT\CurrentVersion\Schedule\TaskCache\Tree'
2022-02-10 14:13:00,922 INFO 19 SessionDynamicLayeringService: Running on a session host thus the filter drivers are already running
2022-02-10 14:13:00,922 INFO 19 CompositingManager: Completing compositing phase PreLogon for user domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx)
2022-02-10 14:13:00,922 INFO 17 WindowsId: Finished impersonating domain\user01
2022-02-10 14:13:00,922 INFO 19 CompositingManager: Waiting for 0 layers to be ready ()
2022-02-10 14:13:00,938 INFO 19 CompositingManager: Configuring layers
2022-02-10 14:13:00,953 INFO 19 UnifltrConfigurationService: New volumeCount = 1 : rescans = 1
2022-02-10 14:13:00,969 INFO 19 CompositingManager: Layering Phase PreLogon Complete
---------== Layering Results ==-----------
User: domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx), Machine: Testuser, ULayer: 21.12.0.4
Assigned Layers:
[Pending] Id: 0x0000000002598002, Revision:  1,  Name: treesize - el,  File: Unidesk/Layers/App/P39419906.R1.vhd
------------------------------------------
2022-02-10 14:13:01,000 INFO 17 VirtualDiskService: Attaching virtual disk '\\c-sofs-p01.zorgmh.local\AppLayer\Unidesk\Layers\App\P39419906.R1.vhd'
2022-02-10 14:13:01,000 INFO 19 CompositingManager: User domain\user01 logged in successfully.  No elastic layers were attached.
2022-02-10 14:13:01,016 INFO 19 AltitudeCheckService: FsLogix filter 'Frxdrvvt' is present and not disabled(System); checking altitude
2022-02-10 14:13:01,031 INFO 19 SessionDynamicLayeringService: Running on a session host thus the common drivers are already running
2022-02-10 14:13:01,031 INFO 19 SessionEventHandler: Finished processing logon event
2022-02-10 14:13:01,031 INFO 19 RequestService: Ending request 1 started on behalf of domain\user01
2022-02-10 14:13:01,313 INFO 17 LayerConfigService: Attached disk: Volume Label 'UDiskP2598002V0R1' : Path '\\?\Volume{0006a695-0000-0000-0000-100000000000}\'
2022-02-10 14:13:20,035 INFO 14 RequestService: Starting request 2 on behalf of domain\user01
2022-02-10 14:13:20,051 INFO 14 HandlerHelper: Processing Query LogonStatusQuery->LogonStatusResult
2022-02-10 14:13:20,067 INFO 14 MachineIdentitySelector: Selected 'nothing' for 'IWindowsSearchIndexService' from 1 options
2022-02-10 14:13:20,067 INFO 14 LogonInfoService: User domain\user01 is not a local user
2022-02-10 14:13:20,067 INFO 14 LogonInfoService: User domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx) is an elastic layer user. Elastic layers are enabled.
2022-02-10 14:13:20,067 INFO 14 CompositingManager: Completing compositing phase PostLogon for user domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx)
2022-02-10 14:13:20,067 INFO 14 CompositingManager: Waiting for 1 layers to be ready (treesize - el)
2022-02-10 14:13:20,067 INFO 14 CompositingManager: Configuring layers
2022-02-10 14:13:20,082 INFO 14 LayerConfigService: Elastic layer 39419906.R1, priority 1
2022-02-10 14:13:20,082 INFO 14 UnifltrConfigurationService: Configure application disk 1: UDiskP2598002V0R1
2022-02-10 14:13:20,285 INFO 14 UnifltrConfigurationService: New volumeCount = 2 : rescans = 2
2022-02-10 14:13:20,301 INFO 14 LayerConfigService: Started 1 LayerStartTasks
2022-02-10 14:13:20,301 INFO 14 CompositingManager: Layering Phase PostLogon Complete
---------== Layering Results ==-----------
User: domain\user01 (S-1-5-xxxxxxxxxxxxxxxxxxxxxxx), Machine: Testuser, ULayer: 21.12.0.4
Assigned Layers:
[Success] Id: 0x0000000002598002, Revision:  1,  Name: treesize - el,  File: Unidesk/Layers/App/P39419906.R1.vhd
------------------------------------------
2022-02-10 14:13:20,301 INFO 17 TaskScheduleService: Processing '39419906.R1 layer' tasks
2022-02-10 14:13:20,301 INFO 14 CompositingManager: User domain\user01 logged in and successfully attached layers: treesize - el
2022-02-10 14:13:20,317 INFO 14 HandlerHelper: Finished Query LogonStatusQuery->LogonStatusResult
2022-02-10 14:13:20,317 INFO 14 RequestService: Ending request 2 started on behalf of domain\user01
2022-02-10 14:13:20,317 INFO 17 TaskScheduleService: Task tree key, not found 'HKLM\RSD_VIRTP2598002V0R1\Registry\Machine\Software\Microsoft\Windows NT\CurrentVersion\Schedule\TaskCache\Tree'
2022-02-10 14:13:20,348 INFO 17 TaskScheduleService: Processed 1 of 1 layers (with 0 failing layers)
2022-02-10 14:13:20,348 INFO 17 TaskScheduleService: Processing user layer tasks
2022-02-10 14:13:20,364 INFO 17 TaskScheduleService: Task tree key, not found 'HKLM\RSD_UepMount\Registry\Machine\Software\Microsoft\Windows NT\CurrentVersion\Schedule\TaskCache\Tree'