VMware Horizon Community
lansti
Hot Shot
Hot Shot
‎02-09-2018 02:48 AM

Appvol is lockling word from saving...

Hi, i have created an appvolume with photoshop elements, it is created/captured on a clean machine...

What we see, is that this appvolume(or other appvolumes) are locling microsoft Word, so users are not able to save their documents.

Office365 is installed locally on the windows 7 image.

Anyone seen this before?

SYSTEM:

Appvil 2.13.2.13

Horizon agent 7.3.2

UEM 9.3.0.804

Best regards
Lansti
Tags (1)
10 Replies
Lakshman
Champion
Champion
‎02-09-2018 09:34 AM

Quick question. If you detatch AppStack, are users able to save word documents locally?

lansti
Hot Shot
Hot Shot
‎02-11-2018 10:06 PM

Yes they are.

Best regards
Lansti
0 Kudos
Lakshman
Champion
Champion
‎02-11-2018 11:57 PM

Could you check if the provisioning VM has Office 365 locally installed or is it a clean VM? Do you see any error message when saving the word document?

0 Kudos
lansti
Hot Shot
Hot Shot
‎02-12-2018 01:53 AM

The provisioning VM is clean, no office installed.

I get an error when i try to save a wordfile, and its telling me that a plugin is missing.

When i unassign the appvolume, i'm able to save in word.

Best regards
Lansti
0 Kudos
Lakshman
Champion
Champion
‎02-12-2018 06:16 AM

Please provide more info about the plugin? Is it part of the master image or from AppStack?

Also check the svservice.log for any errors. VMware Knowledge Base

0 Kudos
lansti
Hot Shot
Hot Shot
‎02-13-2018 12:09 AM

The plugin is for our document system, and it is installed in the golden image. The only thing that is installed the appstack we use right now is Photoshop Elements and MS Visio, in two different Appstacks.

Not sure what i'm looking for in the svservice.log... CAn you please give me a hint?

[2018-02-13 07:27:02.433 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 2)
[2018-02-13 07:27:03.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 3)
[2018-02-13 07:27:04.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 4)
[2018-02-13 07:27:05.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 5)
[2018-02-13 07:27:06.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 6)
[2018-02-13 07:27:07.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 7)
[2018-02-13 07:27:08.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 😎
[2018-02-13 07:27:09.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 9)
[2018-02-13 07:27:10.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 10)
[2018-02-13 07:27:11.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 11)
[2018-02-13 07:27:12.438 UTC] [svservice:P968:T236] HandleNGVC: Waiting for NGVC to complete (count 12)
[2018-02-13 07:27:12.438 UTC] [svservice:P968:T236] HandleNGVC: type 1 size 82 vmPath /MCB/vm/COMPANY Desktop pools/VS32/VS32-039
[2018-02-13 07:27:12.438 UTC] [svservice:P968:T236] Computer UUID (Microsoft format): 34112442-F78F-B65F-B156-46EC8380B229
[2018-02-13 07:27:12.438 UTC] [svservice:P968:T236] Computer UUID (VMware format): 42241134-8ff7-5fb6-b156-46ec8380b229
[2018-02-13 07:27:12.438 UTC] [svservice:P968:T236] Initializing HTTP session
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] Initializing HTTP connection
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] HttpInitializeConnection: Asynchronous volume mounting is: Disabled.
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] Choosing a manager out of 1 configured manager(s)
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] IsDomainJoinedComputer: NetGetJoinInformation() success, domain name DOMAIN and type is 3
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] Pre-startup URL: /pre-startup?name=svservice&uuid=42241134-8ff7-5fb6-b156-46ec8380b229&status=0&osver=6.1.7601&sp=1.0&suite=256&product=1&arch=9&proc=3&agentver=2.13.2.5U&domain=DOMAIN&workstation=VS32-039&vmpath=/MCB/vm/TV%202%20Desktop%20pools/VS32/VS32-039&machinesid=S-1-5-21-1253935013-1254256940-3741800518
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] [0] Connecting to APPVOLSERVER.DOMAIN:443 using HTTPS (attempt 1)
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] WinHttpSendRequestWithSSLCertValidation: SSL certificate validation is disabled.
[2018-02-13 07:27:12.453 UTC] [svservice:P968:T236] WinHttpSendRequestWithSSLCertValidation: WinHttpSetOption(WINHTTP_OPTION_SECURITY_FLAGS) succeeded.
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] WinHttpSendRequestWithSSLCertValidation: WinHttpSendRequest succeeded.
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] HttpReadAllAvailableData: Error 0 in WinHttpQueryDataAvailable: dwSize 0
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] HttpInitializeRequest: Manager status 200 response (2 bytes): OK
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] LogonMount: agent:0 manager:0 volume(s) to attach
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] IsDomainJoinedComputer: NetGetJoinInformation() success, domain name DOMAIN and type is 3
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] Computer startup URL: /computer-startup?name=svservice&uuid=42241134-8ff7-5fb6-b156-46ec8380b229&status=0&osver=6.1.7601&sp=1.0&suite=256&product=1&arch=9&proc=3&agentver=2.13.2.5U&domain=DOMAIN&workstation=VS32-039&pre-startup=1&vmpath=/MCB/vm/TV%202%20Desktop%20pools/VS32/VS32-039&machinesid=S-1-5-21-1253935013-1254256940-3741800518
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] SvdSetReorderCounter: set to -1
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] [0] Connecting to APPVOLSERVER.DOMAIN:443 using HTTPS (attempt 1)
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] WinHttpSendRequestWithSSLCertValidation: SSL certificate validation is disabled.
[2018-02-13 07:27:12.703 UTC] [svservice:P968:T236] WinHttpSendRequestWithSSLCertValidation: WinHttpSetOption(WINHTTP_OPTION_SECURITY_FLAGS) succeeded.
[2018-02-13 07:27:13.547 UTC] [svservice:P968:T236] WinHttpSendRequestWithSSLCertValidation: WinHttpSendRequest succeeded.
[2018-02-13 07:27:13.547 UTC] [svservice:P968:T236] HttpReadAllAvailableData: Error 0 in WinHttpQueryDataAvailable: dwSize 0
[2018-02-13 07:27:13.547 UTC] [svservice:P968:T236] HttpInitializeRequest: Manager status 200 response (24 bytes): STARTUP DOMAIN\VS32-039$
[2018-02-13 07:27:13.547 UTC] [svservice:P968:T236] LogonMount: agent:0 manager:0 volume(s) to attach
[2018-02-13 07:27:13.547 UTC] [svservice:P968:T236] SvdSetReorderCounter: set to 0
[2018-02-13 07:27:13.547 UTC] [svservice:P968:T236] HttpComputerStartupThread: succeeded (computer startup)
[2018-02-13 07:28:55.683 UTC] [svservice:P968:T972] Received SERVICE_CONTROL_INTERROGATE
[2018-02-13 07:38:07.932 UTC] [svservice:P968:T3904] OnLogon called (Session ID 1, Handle 00000000003FEC00, Params 0000000002B7EF10, Context 0000000000000000)
[2018-02-13 07:38:07.936 UTC] [svservice:P968:T3904] OnLogon: DOMAIN\vdi.bruker (NameSamCompatible)
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] OnLogon: CN=VDI Bruker,OU=Oslo,OU=COMPANY Ansatte,OU=1 - Brukere,DC=DOMAIN,DC=no (NameFullyQualifiedDN)
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] OnLogon: VDI.Bruker@DOMAIN.COM (NameUserPrincipal)
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] IsDomainJoinedComputer: NetGetJoinInformation() success, domain name DOMAIN and type is 3
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] GetUserComputerInfo: user:"vdi.bruker" computer:"vs32-039" userdomain:"DOMAIN" computerdomain: "DOMAIN"
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] GetUserProfileDirectoryW failed: error code 2
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] Logged in user is vdi.bruker 
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] OnLogon: skipping scripts because filtering is inactive
[2018-02-13 07:38:07.947 UTC] [svservice:P968:T3904] HttpUserLogin: called 0 logged in (user login)
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] svdriver is running
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] SvdSetReorderCounter: set to -1
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] Initializing HTTP connection
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] HttpInitializeConnection: Asynchronous volume mounting is: Disabled.
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] Choosing a manager out of 1 configured manager(s)
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] User login URL: /user-login?name=svservice&uuid=42241134-8ff7-5fb6-b156-46ec8380b229&status=0&osver=6.1.7601&sp=1.0&suite=256&product=1&arch=9&proc=3&agentver=2.13.2.5U&username=vdi.bruker&domain=DOMAIN&userdomain=DOMAIN&workstation=VS32-039&vmpath=/MCB/vm/TV%202%20Desktop%20pools/VS32/VS32-039&machinesid=S-1-5-21-1253935013-1254256940-3741800518
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] [0] Connecting to APPVOLSERVER.DOMAIN:443 using HTTPS (attempt 1)
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] WinHttpSendRequestWithSSLCertValidation: SSL certificate validation is disabled.
[2018-02-13 07:38:07.951 UTC] [svservice:P968:T3904] WinHttpSendRequestWithSSLCertValidation: WinHttpSetOption(WINHTTP_OPTION_SECURITY_FLAGS) succeeded.
[2018-02-13 07:38:10.205 UTC] [svservice:P968:T3904] WinHttpSendRequestWithSSLCertValidation: WinHttpSendRequest succeeded.
[2018-02-13 07:38:10.205 UTC] [svservice:P968:T3904] HttpReadAllAvailableData: Error 0 in WinHttpQueryDataAvailable: dwSize 0
[2018-02-13 07:38:10.205 UTC] [svservice:P968:T3904] HttpInitializeRequest: Manager status 200 response (250 bytes): *1*#1#LOGIN DOMAIN\VDI.Bruker
MOUNTED-READ;VMware-VDI-AppVols-SSD\cloudvolumes\apps\Adobe!20!Photoshop!20!Elements.vmdk;{b47792d0-692b-4b92-9c06-89582185db5f}
DISABLE-APP;{6f6126e5-f729-49a6-81b8-5384931e0c35};{b47792d0-692b-4b92-9c06-89582185db5f}
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] ReadOutVolsFromString: NewVolumes 1 TotalVolumes 1
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] ReadOutVolsFromString: volume path:"vmware-vdi-appvols-ssd\cloudvolumes\apps\adobe!20!photoshop!20!elements.vmdk" guid:"{b47792d0-692b-4b92-9c06-89582185db5f}" type:"mounted-read"
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] SvdPushReorderEntry: Sent reorder entry to filter {b47792d0-692b-4b92-9c06-89582185db5f} (UserVolume: 1; Writable: 0)
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] ReadOutVolsFromString: add AppStack to load order list:"{b47792d0-692b-4b92-9c06-89582185db5f}"(1)
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] LogonMount: agent:0 manager:1 volume(s) to attach
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] Activate filtering (called by WaitVolumesLoading)
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] WaitVolumesLoading: waiting for 1 total volume(s), 0 processed, max wait 180
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] WaitVolumesLoading: Wait for first volume only is 1
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] Releasing user logon, (Writable present: 0; Writable processed: 0)
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T316] MeasureTime::RecordCenter: Start recording  GUID:{2841e2d6-842b-11e7-9d72-005056a9518e} Type:0
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T316] Preload volume event (startup): "\Device\HarddiskVolume2" GUID {2841e2d6-842b-11e7-9d72-005056a9518e} Hive  (0 logged in, SystemVolume 1, VolumeType 0)
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] SvdSetReorderCounter: set to 0
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] HttpUserLogin: succeeded (user login)
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T3904] OnLogon : succeeded
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T316] Sending reply to SVCMD_ID_NEW_VOLUME_PRE (Message 3, Size 24)
[2018-02-13 07:38:10.209 UTC] [svservice:P968:T1604] WaitVolumesLoadingWorker: waiting for 1 total volume(s), 0 processed, max wait 180
[2018-02-13 07:38:10.404 UTC] [svservice:P968:T316] MeasureTime::RecordCenter: Start recording  GUID:{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} Type:0
[2018-02-13 07:38:10.404 UTC] [svservice:P968:T316] Preload volume event (startup): "\Device\HarddiskVolume3" GUID {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} Hive  (0 logged in, SystemVolume 0, VolumeType 0)
[2018-02-13 07:38:10.404 UTC] [svservice:P968:T316] Worker: read meta ID:("{b47792d0-692b-4b92-9c06-89582185db5f}") success!
[2018-02-13 07:38:10.404 UTC] [svservice:P968:T316] Detected appstack volume. Path: \Device\HarddiskVolume3 GUID: {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}
[2018-02-13 07:38:10.404 UTC] [svservice:P968:T316] PreCheckVolume: Volume \Device\HarddiskVolume3 checking {b47792d0-692b-4b92-9c06-89582185db5f}
[2018-02-13 07:38:10.404 UTC] [svservice:P968:T316] PreCheckVolume: Volume free space is 13546917888 bytes and total space is 16102977536 bytes
[2018-02-13 07:38:10.404 UTC] [svservice:P968:T316] Read registry value VolAttachMessageOn (value is 0)
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] HttpQueryVolumeUpdate: called
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] Checking provisioning status
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] Initializing HTTP connection
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] HttpInitializeConnection: Asynchronous volume mounting is: Disabled.
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] Choosing a manager out of 1 configured manager(s)
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] IsDomainJoinedComputer: NetGetJoinInformation() success, domain name DOMAIN and type is 3
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] QueryVolumeUpdate URL: /computer-provisioning-status?name=svservice&uuid=42241134-8ff7-5fb6-b156-46ec8380b229&status=0&osver=6.1.7601&sp=1.0&suite=256&product=1&arch=9&proc=3&agentver=2.13.2.5U&domain=DOMAIN&workstation=VS32-039&vmpath=/MCB/vm/TV%202%20Desktop%20pools/VS32/VS32-039&machinesid=S-1-5-21-1253935013-1254256940-3741800518
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] [0] Connecting to APPVOLSERVER.DOMAIN:443 using HTTPS (attempt 1)
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] WinHttpSendRequestWithSSLCertValidation: SSL certificate validation is disabled.
[2018-02-13 07:38:10.408 UTC] [svservice:P968:T316] WinHttpSendRequestWithSSLCertValidation: WinHttpSetOption(WINHTTP_OPTION_SECURITY_FLAGS) succeeded.
[2018-02-13 07:38:10.623 UTC] [svservice:P968:T316] WinHttpSendRequestWithSSLCertValidation: WinHttpSendRequest succeeded.
[2018-02-13 07:38:10.623 UTC] [svservice:P968:T316] HttpReadAllAvailableData: Error 0 in WinHttpQueryDataAvailable: dwSize 0
[2018-02-13 07:38:10.623 UTC] [svservice:P968:T316] HttpInitializeRequest: Manager status 200 response (2 bytes): No
[2018-02-13 07:38:10.623 UTC] [svservice:P968:T316] HttpQueryVolumeUpdate: succeeded
[2018-02-13 07:38:10.623 UTC] [svservice:P968:T316] PreCheckVolume: modify appstack: "No"
[2018-02-13 07:38:10.623 UTC] [svservice:P968:T316] Creating mount point at "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\"
[2018-02-13 07:38:10.623 UTC] [svservice:P968:T316] "\\?\Volume{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\" mounted at "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\"
[2018-02-13 07:38:10.627 UTC] [svservice:P968:T316] Checking for scripts on "\Device\HarddiskVolume3" (event prestartup)
[2018-02-13 07:38:10.627 UTC] [svservice:P968:T316] Sending reply to SVCMD_ID_NEW_VOLUME_PRE (Message 4, Size 24)
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] MeasureTime::RecordCenter: Start recording  GUID:{2841e2d6-842b-11e7-9d72-005056a9518e} Type:1
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] New volume event (startup): "\Device\HarddiskVolume2" GUID {2841e2d6-842b-11e7-9d72-005056a9518e} MetaGuid  Hive \REGISTRY\MACHINE\SnapVolumes-{2841e2d6-842b-11e7-9d72-005056a9518e} (0 logged in, SystemVolume 1, VolumeType 1, Hide 0)
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] Sending reply to SVCMD_ID_NEW_VOLUME (Message 5)
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] MeasureTime::RecordCenter: End recording  GUID:{2841e2d6-842b-11e7-9d72-005056a9518e} Type:1
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] Starting services on a volume "\Device\HarddiskVolume2" (GUID {2841e2d6-842b-11e7-9d72-005056a9518e}, SystemVolume 1)
Reading services from "\REGISTRY\MACHINE\SnapVolumes-{2841e2d6-842b-11e7-9d72-005056a9518e}\MACHINE\System\ControlSet001\Services"
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] Checking for boot drivers
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] Checking for system drivers
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] Checking for auto-start services
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] MeasureTime::RecordCenter: Start recording  GUID:{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} Type:2
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] New volume event (mounted): "\Device\HarddiskVolume3" GUID {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} MetaGuid {b47792d0-692b-4b92-9c06-89582185db5f} Hive \REGISTRY\MACHINE\SnapVolumes-{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} (0 logged in, SystemVolume 0, VolumeType 2, Hide 0)
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] GetRunKeyEntries: Run: "AdobeAAMUpdater-1.0"(""C:\Program Files (x86)\Common Files\Adobe\OOBE\PDApp\UWA\UpdaterStartupUtility.exe"")
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] GetRunKeyEntries: In total 1(1) value(s) processed!
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] GetRunKeyEntries: No autorun values in \REGISTRY\MACHINE\SnapVolumes-{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\MACHINE\SOFTWARE\Wow6432Node\Microsoft\Windows\CurrentVersion\Run
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316]  "\Device\HarddiskVolume3" SnapvolType 2 Hide 0
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] Checking for scripts on "\Device\HarddiskVolume3" (event startup)
[2018-02-13 07:38:10.732 UTC] [svservice:P968:T316] RunScript: Launching "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\startup.bat" (event startup, CreationFlag 0x08000020, wait -1 ms)
[2018-02-13 07:38:10.744 UTC] [svservice:P968:T316] Successfully launched: \SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\startup.bat (wait -1 ms)
[2018-02-13 07:38:10.971 UTC] [svservice:P968:T316] Finished waiting for "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\startup.bat" (WaitStatus 0, ExitCode 0)
[2018-02-13 07:38:10.971 UTC] [svservice:P968:T316] Checking for scripts on "\Device\HarddiskVolume3" (event logon)
[2018-02-13 07:38:10.971 UTC] [svservice:P968:T316] DriverStore not found on \Device\HarddiskVolume3
[2018-02-13 07:38:10.971 UTC] [svservice:P968:T316] Sending reply to SVCMD_ID_NEW_VOLUME (Message 7)
[2018-02-13 07:38:10.971 UTC] [svservice:P968:T316] MeasureTime::RecordCenter: End recording  GUID:{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} Type:2
[2018-02-13 07:38:10.971 UTC] [svservice:P968:T316] Starting services on a volume "\Device\HarddiskVolume3" (GUID {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}, SystemVolume 0)
Reading services from "\REGISTRY\MACHINE\SnapVolumes-{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\MACHINE\System\ControlSet001\Services"
[2018-02-13 07:38:10.971 UTC] [svservice:P968:T316] Service "AdobeActiveFileMonitor11.0" needs to be registered (creating)
[2018-02-13 07:38:10.982 UTC] [svservice:P968:T316] Service "AGSService" needs to be registered (creating)
[2018-02-13 07:38:10.986 UTC] [svservice:P968:T316] Service "cdrom" is already registered (reconfiguring)
[2018-02-13 07:38:10.986 UTC] [svservice:P968:T316] Unable to reconfigure service "cdrom": error 87
[2018-02-13 07:38:10.986 UTC] [svservice:P968:T316] Service "eventlog" is already registered (reconfiguring)
[2018-02-13 07:38:10.998 UTC] [svservice:P968:T316] Service "PxHlpa64" needs to be registered (creating)
[2018-02-13 07:38:10.998 UTC] [svservice:P968:T316] Checking for boot drivers
[2018-02-13 07:38:11.002 UTC] [svservice:P968:T316] Starting service "PxHlpa64" (type 0)
[2018-02-13 07:38:11.057 UTC] [svservice:P968:T316] Checking for system drivers
[2018-02-13 07:38:11.057 UTC] [svservice:P968:T316] Checking for auto-start services
[2018-02-13 07:38:11.057 UTC] [svservice:P968:T316] Starting service "AdobeActiveFileMonitor11.0" (type 2)
[2018-02-13 07:38:11.209 UTC] [svservice:P968:T1604] Waiting for 1 new volumes before resetting order (1 processed, waited 1 second(s) so far)
[2018-02-13 07:38:11.221 UTC] [svservice:P968:T316] Starting service "AGSService" (type 2)
[2018-02-13 07:38:11.268 UTC] [svservice:P968:T316] Worker: running scripts after starting services (0 logged in)
[2018-02-13 07:38:11.268 UTC] [svservice:P968:T316] Checking for scripts on "\Device\HarddiskVolume3" (event startup_postsvc)
[2018-02-13 07:38:11.268 UTC] [svservice:P968:T316] RunScript: Launching "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\startup_postsvc.bat" (event startup_postsvc, CreationFlag 0x08000020, wait -1 ms)
[2018-02-13 07:38:11.272 UTC] [svservice:P968:T316] Successfully launched: \SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\startup_postsvc.bat (wait -1 ms)
[2018-02-13 07:38:11.311 UTC] [svservice:P968:T316] Finished waiting for "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\startup_postsvc.bat" (WaitStatus 0, ExitCode 0)
[2018-02-13 07:38:11.311 UTC] [svservice:P968:T316] Checking for scripts on "\Device\HarddiskVolume3" (event logon_postsvc)
[2018-02-13 07:38:11.311 UTC] [svservice:P968:T316] Sending reply to SVCMD_ID_LAST_VOLUME (Message 11)
[2018-02-13 07:38:11.311 UTC] [svservice:P968:T316] SetRegConfigDWord(VolReady, 1) success
[2018-02-13 07:38:11.311 UTC] [svservice:P968:T316] Checking for scripts on "\Device\HarddiskVolume3" (event allvolattached)
[2018-02-13 07:38:11.315 UTC] [svservice:P968:T316] RunScript: "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\allvolattached.bat" has size zero
[2018-02-13 07:38:11.315 UTC] [svservice:P968:T316] All volumes finished processing
[2018-02-13 07:38:11.315 UTC] [svservice:P968:T316] User has not configured for checking of VM persistence
[2018-02-13 07:38:11.315 UTC] [svservice:P968:T3676] User has not configured for checking of Windows Update Service status
[2018-02-13 07:38:37.650 UTC] [svservice:P968:T3904] OnStartShell called (Session ID 1, Handle 00000000003FEC00, Params 0000000002B7EF58, Context 0000000000000000)
[2018-02-13 07:38:37.650 UTC] [svservice:P968:T3904] OnStartShell: DOMAIN\vdi.bruker (NameSamCompatible)
[2018-02-13 07:38:37.650 UTC] [svservice:P968:T3904] Checking for scripts on "\Device\HarddiskVolume3" (event shellstart)
[2018-02-13 07:38:37.654 UTC] [svservice:P968:T3904] RunScript: user script (event shellstart) on "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\" go process.
[2018-02-13 07:38:37.654 UTC] [svservice:P968:T3904] RunExecutableAsUser: Path "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\shellstart.bat"
CreateProcessWithTokenAndEnvBlockW() standard user or UAC turned off, continue...
[2018-02-13 07:38:37.662 UTC] [svservice:P968:T3904] Successfully launched (elevated privileges): \SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\shellstart.bat (wait -1 ms), pid=4264 tid=4260
[2018-02-13 07:38:37.732 UTC] [svservice:P968:T3904] Finished waiting for "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\shellstart.bat": CreationFlag 0x08000420, WaitStatus 0x00000000, ExitCode 0 (0x00)
[2018-02-13 07:38:37.736 UTC] [svservice:P968:T3904] Successfully launched: \SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\shellstart.bat (wait -1 ms)
[2018-02-13 07:38:37.736 UTC] [svservice:P968:T3904] RunScript: user script (event windows_install_fonts) on "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\" go process.
[2018-02-13 07:38:37.736 UTC] [svservice:P968:T3904] RunExecutableAsUser: CommandLine "C:\Program Files (x86)\Common Files\Adobe\OOBE\PDApp\UWA\UpdaterStartupUtility.exe"
CreateProcessWithTokenAndEnvBlockW() standard user or UAC turned off, continue...
[2018-02-13 07:38:37.740 UTC] [svservice:P968:T3904] CreateProcessWithTokenAndEnvBlockW: CreateProcessAsUserW failed for ""C:\Program Files (x86)\Common Files\Adobe\OOBE\PDApp\UWA\UpdaterStartupUtility.exe"": error 2
[2018-02-13 07:38:37.740 UTC] [svservice:P968:T3904] Failed to execute run key entry: "C:\Program Files (x86)\Common Files\Adobe\OOBE\PDApp\UWA\UpdaterStartupUtility.exe" - 2
[2018-02-13 07:38:37.740 UTC] [svservice:P968:T3904] Checking for scripts on "\Device\HarddiskVolume3" (event allvolattached_shellstarted)
[2018-02-13 07:38:37.740 UTC] [svservice:P968:T3904] RunScript: user script (event allvolattached_shellstarted) on "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\" go process.
[2018-02-13 07:38:37.740 UTC] [svservice:P968:T3904] RunExecutableAsUser: Path "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\allvolattached_shellstarted.bat"
CreateProcessWithTokenAndEnvBlockW() standard user or UAC turned off, continue...
[2018-02-13 07:38:37.752 UTC] [svservice:P968:T3904] Successfully launched (elevated privileges): \SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\allvolattached_shellstarted.bat (wait 0 ms), pid=3976 tid=2960
[2018-02-13 07:38:37.752 UTC] [svservice:P968:T3904] Successfully launched: \SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\allvolattached_shellstarted.bat (wait 0 ms)
[2018-02-13 07:38:37.752 UTC] [svservice:P968:T3904] Refreshing desktop (hToken 00000000000005E8)
[2018-02-13 07:38:37.775 UTC] [svservice:P968:T3904] RunExecutableAsUser: Path "C:\Program Files (x86)\CloudVolumes\Agent\svservice.exe"
[2018-02-13 07:38:37.775 UTC] [svservice:P968:T3904] RunExecutableAsUser: CommandLine svservice.exe refresh
CreateProcessWithTokenAndEnvBlockW() standard user or UAC turned off, continue...
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] Successfully launched (elevated privileges): svservice.exe refresh (wait 0 ms), pid=4436 tid=4432
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] Successfully launched: svservice.exe refresh (wait 0 ms)
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] Checking for svcapture on "\Device\HarddiskVolume3" (event svcapture)
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] RunScript: creating thread to check provisioning state
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] Initializing HTTP connection
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] HttpInitializeConnection: Asynchronous volume mounting is: Disabled.
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] Choosing a manager out of 1 configured manager(s)
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] IsDomainJoinedComputer: NetGetJoinInformation() success, domain name DOMAIN and type is 3
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] HttpFileShareRequest: File Share UR: /log_fileshares/active?name=svservice&uuid=42241134-8ff7-5fb6-b156-46ec8380b229&status=0&osver=6.1.7601&sp=1.0&suite=256&product=1&arch=9&proc=3&agentver=2.13.2.5U&domain=DOMAIN&workstation=VS32-039&vmpath=/MCB/vm/TV%202%20Desktop%20pools/VS32/VS32-039&machinesid=S-1-5-21-1253935013-1254256940-3741800518
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] [0] Connecting to APPVOLSERVER.DOMAIN:443 using HTTPS (attempt 1)
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] WinHttpSendRequestWithSSLCertValidation: SSL certificate validation is disabled.
[2018-02-13 07:38:37.779 UTC] [svservice:P968:T3904] WinHttpSendRequestWithSSLCertValidation: WinHttpSetOption(WINHTTP_OPTION_SECURITY_FLAGS) succeeded.
[2018-02-13 07:38:37.845 UTC] [svservice:P4436:T4432] *** Started
[2018-02-13 07:38:37.849 UTC] [svservice:P4436:T4432] Refreshing desktop
[2018-02-13 07:38:37.849 UTC] [svservice:P4436:T4432] Refreshing Environment
[2018-02-13 07:38:38.162 UTC] [svservice:P968:T3904] WinHttpSendRequestWithSSLCertValidation: WinHttpSendRequest succeeded.
[2018-02-13 07:38:38.162 UTC] [svservice:P968:T3904] HttpReadAllAvailableData: Error 0 in WinHttpQueryDataAvailable: dwSize 0
[2018-02-13 07:38:38.162 UTC] [svservice:P968:T3904] HttpFileShareRequest: succeeded (computer startup)
[2018-02-13 07:38:38.162 UTC] [svservice:P968:T3904] handleFileShareStr: No file share path found.
[2018-02-13 07:38:38.162 UTC] [svservice:P968:T3904] OnStartShell: Error Failed to Start DCT Logger
[2018-02-13 07:38:38.779 UTC] [svservice:P968:T4392] ReplicateFonts_Install: 140 of 140 font files replicated, 0 previously replicated
[2018-02-13 07:38:38.783 UTC] [svservice:P968:T4392] RunScript: user script (event windows_install2_fonts) on "\SnapVolumesTemp\MountPoints\{8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}\" go process.
[2018-02-13 07:38:38.783 UTC] [svservice:P968:T4392] RunExecutableAsUser: Path "C:\Program Files (x86)\CloudVolumes\Agent\svservice.exe"
[2018-02-13 07:38:38.783 UTC] [svservice:P968:T4392] RunExecutableAsUser: CommandLine svservice.exe updatefonts install2 {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}
CreateProcessWithTokenAndEnvBlockW() standard user or UAC turned off, continue...
[2018-02-13 07:38:38.791 UTC] [svservice:P968:T4392] Successfully launched (elevated privileges): svservice.exe updatefonts install2 {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} (wait -1 ms), pid=4612 tid=4892
[2018-02-13 07:38:43.627 UTC] [svservice:P4436:T4432] Finished refreshing environment successfully
[2018-02-13 07:38:43.787 UTC] [svservice:P4612:T4892] *** Started
[2018-02-13 07:38:45.154 UTC] [svservice:P4612:T4892] RegisterFonts: 140 of 140 font files registered
[2018-02-13 07:38:45.158 UTC] [svservice:P968:T4392] Finished waiting for "svservice.exe updatefonts install2 {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1}": CreationFlag 0x08000420, WaitStatus 0x00000000, ExitCode 0 (0x00)
[2018-02-13 07:38:45.158 UTC] [svservice:P968:T4392] Successfully launched: svservice.exe updatefonts install2 {8cbb8cb0-02ed-11e8-bf55-005056a4b4c1} (wait -1 ms)
Best regards
Lansti
0 Kudos
lansti
Hot Shot
Hot Shot
‎02-13-2018 12:16 AM

It also seems that Appvols are breaking something with Skype for Busines. When a user have Appvols, they are not able to search within skype, no results are coming up, and Skype is also popping up in front every now and then(often, very often)!

Best regards
Lansti
0 Kudos
Lakshman
Champion
Champion
‎02-13-2018 10:07 AM

From the log, unable to figure out why word cannot save file. Suggest you to raise a SR with VMware support to look into the issue in detail.

For Skype search issue, please have a look at this thread:

Writable Profiles and Skype 2016

0 Kudos
lansti
Hot Shot
Hot Shot
‎02-13-2018 01:52 PM

Hi, thanks for your reply.

After some more research i figured out that i need to provision my appstacks with an image that is similar to my golden image. So i have now cloned my image and tried it out. I'm waiting for a couple of users to report back their experience.

BUT!!! We used a vmware certified specialist that helped us out with installation of our Vmware environment, and he told me to use a totally clean image, when i went to a vmware course, i asked the course leader that is a certified vmware instructor, and he also recommended me to use a totally clean image without anything installed. Even if i said that we are using thick images.

Then i came across this article: Preparing a Provisioning Machine during my research:

For example, the provisioning virtual machine and the target should be at the same patch and service pack level. If you have included applications in the base image, they should also be present in the provisioning virtual machine.

So much for expert advice...

But as i said, i'm waiting for my testusers to report back their experence, but as far as i can see, the issue with not saving word docuemnts seems to be solved.

Regarding Skype, I'm also waiting for users to report back, when I tested this earlier today, the search did not work, but i read something about waiting for 30 minutes or so for the GAL file to build up.

Your link in the post aboe, we do not use writable volumes yet, Office and Skype are both installed on the golden image. So tomorrow can be a breakthrough within this case...

Finger crossed.

Best regards
Lansti
0 Kudos
Ray_handels
Virtuoso
Virtuoso
‎02-13-2018 11:58 PM

I think that a lot of trainers haven't worked with Appvolumes yet and make assumptions that it must be something like ThinApp.

I did a training on Horizon View and we needed to explain what Appvolumes actually does to our trainer (who was well known with the Horizon Suite and did an excellent job training).

0 Kudos