App Volumen agent not mounting any apps

[mboye_grundfos]

Hi.
So I have an issue with my app volume agent not starting on the VDI machines when I e.g. update windows.

Only way I have been able to fix it is to reinstall the app volume agent, which cannot be the best way.

So what i do is

1. Power on golden image.
2. Start VMWareOSOptimizationTool
3. Enable windows update
4. start and run windows update
5. reboot
6. open VMWareOSOptimizationTool
7. Reapply optimization
8. finalize image
9. shutdown golden image
10. snapshot golden image
11. publish new snapshot of golden image to the VDI desktop.

When provisioning has completed and the new image is available, no app volume is mounted. The app Volume service is set to disabled. If i go and enable it, nothing happens. I have tried to add a step between item 7. and 8. in the list above where i go an enable the service before finalizing the image, to see if that changed anything. It did not.

If start a an admin command prompt, and go to the svservice.exe and execute svservice run to have the console output i see the following entry being repeated when I manually start the app volume agent service. The output is from when my user login to the VDI desktop:

[2021-05-05 14:22:21.291 UTC] [svservice:P2136:T236] OnLogon called (Session ID 1, Handle 000001E8208F2E60, Params 0000005D78CFED30, Context 0000000000000000)
[2021-05-05 14:22:21.291 UTC] [svservice:P2136:T236] OnLogon: domain\username (NameSamCompatible)
[2021-05-05 14:22:21.305 UTC] [svservice:P2136:T236] OnLogon: CN=username,OU=path,OU=in,OU=active,OU=directory,DC=domain,DC=,DC=company,DC=com (NameFullyQualifiedDN)
[2021-05-05 14:22:21.305 UTC] [svservice:P2136:T236] OnLogon: username@company.com (NameUserPrincipal)
[2021-05-05 14:22:21.305 UTC] [svservice:P2136:T236] NotifyLoginStarted failed: error 0x80070002
[2021-05-05 14:22:21.307 UTC] [svservice:P2136:T236] IsDomainJoinedComputer: NetGetJoinInformation() success, domain name domain and type is 3
[2021-05-05 14:22:21.308 UTC] [svservice:P2136:T236] GetUserComputerInfo: user:"username" computer:"vdidekstop-05" userdomain:"domain" computerdomain: "domain"
[2021-05-05 14:22:21.308 UTC] [svservice:P2136:T236] GetUserProfileDirectoryW failed: error code 2
[2021-05-05 14:22:21.309 UTC] [svservice:P2136:T236] Logged in user is username 
[2021-05-05 14:22:21.309 UTC] [svservice:P2136:T236] OnLogon: skipping scripts because filtering is inactive
[2021-05-05 14:22:21.310 UTC] [svservice:P2136:T236] CDelayVirtualizationHandler::Initialize: Delay virtualization flag - 1.
[2021-05-05 14:22:21.311 UTC] [svservice:P2136:T236] GetViewClientIdValue: Unable to open key Volatile Environment\1: error 2
[2021-05-05 14:22:21.311 UTC] [svservice:P2136:T236] GetViewClientIdValue: Pool ID value in key Software\VMware, Inc.\VMware VDM\SessionData\1 is Win10_32Cores64GBRAM
[2021-05-05 14:22:21.311 UTC] [svservice:P2136:T236] HttpUserLogin: called 0 logged in (user login)
[2021-05-05 14:22:21.311 UTC] [svservice:P2136:T236] svdriver is stopped
[2021-05-05 14:22:21.311 UTC] [svservice:P2136:T236] HttpUserLogin: called svdriver is not running (ignoring event)
[2021-05-05 14:22:21.312 UTC] [svservice:P2136:T236] OnLogon : succeeded
[2021-05-05 14:22:22.136 UTC] [svservice:P2136:T2860] Attempting to restart communication with driver
[2021-05-05 14:22:22.136 UTC] [svservice:P2136:T2860] SvdOpen: FilterConnectCommunicationPort returned HRESULT 0x80070002
[2021-05-05 14:22:25.133 UTC] [svservice:P2136:T2860] Attempting to restart communication with driver
[2021-05-05 14:22:25.133 UTC] [svservice:P2136:T2860] SvdOpen: FilterConnectCommunicationPort returned HRESULT 0x80070002
[2021-05-05 14:22:28.131 UTC] [svservice:P2136:T2860] Attempting to restart communication with driver
[2021-05-05 14:22:28.131 UTC] [svservice:P2136:T2860] SvdOpen: FilterConnectCommunicationPort returned HRESULT 0x80070002
[2021-05-05 14:22:30.300 UTC] [svservice:P2136:T236] OnStartShell called (Session ID 1, Handle 000001E8208F2E60, Params 0000005D78CFED68, Context 0000000000000000)
[2021-05-05 14:22:30.300 UTC] [svservice:P2136:T236] OnStartShell: domain\username (NameSamCompatible)
[2021-05-05 14:22:30.300 UTC] [svservice:P2136:T236] NotifyLoginCompleted failed: error 0x80070002
[2021-05-05 14:22:30.301 UTC] [svservice:P2136:T236] HttpFileShareRequest WinHttp over SSL is disabled. Log collection to file share not supported.
[2021-05-05 14:22:30.301 UTC] [svservice:P2136:T236] handleFileShareStr: File share info received from manager is empty.
[2021-05-05 14:22:30.301 UTC] [svservice:P2136:T236] OnStartShell: Error Failed to Start DCT Logger
[2021-05-05 14:22:31.129 UTC] [svservice:P2136:T2860] Attempting to restart communication with driver
[2021-05-05 14:22:31.129 UTC] [svservice:P2136:T2860] SvdOpen: FilterConnectCommunicationPort returned HRESULT 0x80070002
[2021-05-05 14:22:34.127 UTC] [svservice:P2136:T2860] Attempting to restart communication with driver
[2021-05-05 14:22:34.127 UTC] [svservice:P2136:T2860] SvdOpen: FilterConnectCommunicationPort returned HRESULT 0x80070002
[2021-05-05 14:22:37.125 UTC] [svservice:P2136:T2860] Attempting to restart communication with driver

How do I fix this? What am I doing wrong in this setup of updating golden image? Golden Image is a windows 10 pro image.

Best Regards,

Mads.

[praviview]

just check any windows policy which is not allowing to mount any more hard disk in to the system. 

[slater0013]

Hello,

Horizon 8.3 last update & AppVol 4.4.4.6 last update, and having the same issue !

The AppVol Service is disabled when clicking on Enable Windows Update button ! And It's not enabled back when optimizing/finalizing.

Last OSOT version here 2107.

Will try to contact them !

GS.

[praviview]

best thing what you can do is enable hotplug in your Golden image, three is a hard limit of 8 or 10 apps stacks to attach by default. 

[slater0013]

The problem is not being limited to mount more than x vApps !

The problem is that the AppVol service is disabled, so 0 vApps are mounted.

Regards,

GS.

[jhol5]

You have to use VMWareOSOptimizationTool to re-disable windows updates using the Windows Update tab. One of the things this tab does that isn't listed is disabling/enabling the App Volumes service. The Optimization process may re-disable windows updates but it won't enable the App Volumes service. Unless it's been updated, the Optimization Tool guide skips over this step in its second-day operation steps.

[mboye_grundfos]

@jhol5That is exactly what I have been using, but normailly I check for a newer version of the VMWareOSOptimizationTool and rerun the optimization. I am about to do a VDI image update, will check if that is the case. I guess it is as simple as enable the APP volumes service before closing the VM, and pushing the new image?

BR. Mads.

[FlowDE]

Hey all,

our Masterimage is not joined the domain, therefore each login would take 5 Minutes till the timout occure. Also while deploying a new Masterimage sometimes the template get some Appstacks attached (Computer Assignment)

Therefore our App Volumes Service is on manual and get started via a Script on the Horizon deployment process.

Maybe that helps

Greetings

JT

[Micheal_A]

You need to follow a few guidelines to manage your Gold Image (GI).

1. Never login into your GI with an account that has App Volumes packaged assigned
2. Never assign App Volumes packages to the GI-VM.
3. Always STOP App Volumes Service before shutdown

Here is a script that I use to shutdown the GI-VM after completing the OSOT Finalize.

There is still somethings the OSOT does not complete after running the Finalization.

• REM OSOT Pre-SnapShot Shutdown:
  Set COMPANYNAME==TADH
  set IMAGESTAMP="%COMPANYNAME%" Master Image %DATE:~10,4%%DATE:~4,2%%DATE:~7,2%

  REM AppVol Stop Service
  NET START | FIND "App Volumes Service" >nul
  IF errorlevel 0 NET STOP "App Volumes Service"

  REM Delete AppVol SvService.log file
  del /F /S /Q "%PROGRAMFILES(x86)%\CloudVolumes\Agent\Logs\svservice.log"
  del /F /S /Q "%PROGRAMFILES%\CloudVolumes\Agent\Logs\svservice.log"

  REM Update Image Properties
  reg add "HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\Windows\CurrentVersion\OEMInformation" /v Model /t REG_SZ /d "%IMAGESTAMP%" /f

  REM Rearm Office 2016
  "%PROGRAMFILES(x86)%\Microsoft Office\Office16\OSPPREARM.EXE"

  shutdown /s /t 0 /c "Image Ready"

I have never had App Volumes mount packages. 

[100101010100110]

I am running into an issue that has to do with my running OSOT. I see you said to disable app vol service before shutdown, why is this, and how do the VDI guests start with the service enabled?

[Micheal_A]

I fixed the post to state STOP not Disable.

You do not disable the service, just stop the AppVolumes service.

REM AppVol Stop Service
NET START | FIND "App Volumes Service" >nul
IF errorlevel 0 NET STOP "App Volumes Service"

REM Delete AppVol SvService.log file
del /F /S /Q "%PROGRAMFILES(x86)%\CloudVolumes\Agent\Logs\svservice.log"
del /F /S /Q "%PROGRAMFILES%\CloudVolumes\Agent\Logs\svservice.log"

You need to have the service stopped and the logs cleared before you create Instant-Clones from the Gold Image. You want each IC VM to have a fresh start for that VM.