14 Replies Latest reply on Sep 22, 2018 4:02 AM by Ray_handels

    App Volumes not getting applied to instant clone

    JohnFLi Novice

      I have no idea where this is getting posted, nor even where to look to see if anybody else has had this issue.

       

      My company has several ESXi hosts, etc and so forth.

      I have the trial of Horizon 7 and app volumes.

       

      I have created a instant-clone pool which seems to work fine.

      I setup and installed App Volumes.

       

      Did all the steps to create an AppStack to push out Notepadd++.   (should be simple enough)

      installed it on the provisional system, completed, rebooted, etc, etc....

      all seems good.

      I then assign the appStack to a user.

      That user then logs onto one of the instant clones......

      No Notepad++.

       

      I don't see any mention of it even trying to apply.

      zero mention of it at C:\Program Files (x86)\CloudVolumes\Manager\log

       

      any ideas one what to look at?

      I tried contacting support, but becasue i am using the trial, they told me to F off.

        • 1. Re: App Volumes not getting applied to instant clone
          Ray_handels Master
          vExpertCommunity Warriors

          Do you actually see it connecting to the appvolumes manager server? Normally in the logging it should say soemthing like cannot connect to Appvolumes manager or some sort.

          Did you provide your Appvolumes manager with a trusted certificate or are you still using the default? If so, try to disable Certificate checking.

           

          Disable SSL Certificate Validation in App Volumes Agent After Installation

          • 2. Re: App Volumes not getting applied to instant clone
            JohnFLi Novice

            Thank you for your reply.

             

            I did as you suggested.

            Still didn't get anything.

             

            Deleted the appStack

             

            re-made the appstack, assigned it to 1 person.

             

            logged into the clone as that user, still nothing.

             

            Looked in the  C:\Program Files (x86)\CloudVolumes\Manager\log\production000001.log file, don't see anything related.

             

            in App Volumes manager, under  Directory/Users     I can see the test user I assigned it to,   It shows that it has 1 app assigned to it, under log ins, it shows a zero.

             

            Any thoughts on where to look for any errors??

            • 3. Re: App Volumes not getting applied to instant clone
              Ray_handels Master
              Community WarriorsvExpert

              Other than the log file on the agent not really. Could you try and post a snap of the logfile in which you see the error? Are you able to ping the appvolumes manager from the client?

              • 4. Re: App Volumes not getting applied to instant clone
                JohnFLi Novice

                I don't find any logs on the machine that is supposed to have the application applied to.

                 

                I don't get any error message.

                 

                They can ping back and forth all day long   (they are on the same network)

                • 5. Re: App Volumes not getting applied to instant clone
                  Ray_handels Master
                  Community WarriorsvExpert

                  Could you please try and look into the C:\Program Files (x86)\CloudVolumes\Agent\Logs\svservice.log. In that log file you actually see what's happening when you log in.

                  Without logging it is quite impossible to see what is going wrong without looking at an environment.

                   

                  And looking at your post, did you even install the agent on the instant clone machine?

                  • 6. Re: App Volumes not getting applied to instant clone
                    JohnFLi Novice

                    perhaps that is the root of the problem:

                     

                    "C:\Program Files (x86)\CloudVolumes\Agent\Logs\svservice.log."

                    the "C:\Program Files (x86)\CloudVolumes\ Agent" only exists on the system that I use to computer that I use to create the app stack and provision.

                     

                    DO i need to install the agent on the base image as well?

                    (if so, I didn't see that part on the limited documentation for app volumes)

                    • 7. Re: App Volumes not getting applied to instant clone
                      JohnFLi Novice

                      Ok, i'm a little further now......

                       

                      Now, when I log into the clone, i get a message box saying "Error from manager <ip address> (error code 400): unable to locate the machine making this request on the hypervisor      Virtualization is disabled"

                       

                      The system is joined to the domain

                      they can ping back and forth with each other.

                      it is in the correct OU

                      from the clone, i can telnet at port 80 and 443

                      the clones ip address is (10.100.5.154 and the apps Volume Manager is 10.100.5.142)

                       

                       

                       

                       

                       

                       

                      2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] Message: "Error from Manager "10.100.5.142" (error code 400):

                      Unable to locate the machine making this request on the hypervisor

                       

                       

                      Virtualization is disabled" (hToken 00000000000003E0)

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] RunExecutableAsUser: Path "C:\Program Files (x86)\CloudVolumes\Agent\svservice.exe"

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] RunExecutableAsUser: CommandLine svservice.exe message "Error from Manager "10.100.5.142" (error code 400):

                      Unable to locate the machine making this request on the hypervisor

                       

                       

                      Virtualization is disabled"

                      CreateProcessWithTokenAndEnvBlockW() standard user or UAC turned off, continue...

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3784] Waiting 0 second(s) for a new volume

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3784] Activate filtering (called by DelayActivateWorker)

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T1316] MeasureTime::RecordCenter: Start recording  GUID:{52877c63-0000-0000-0000-501f00000000} Type:0

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T1316] Preload volume event (startup): "\Device\HarddiskVolume2" GUID {52877c63-0000-0000-0000-501f00000000} Hive  (1 logged in, SystemVolume 1, VolumeType 0)

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T1316] Sending reply to SVCMD_ID_NEW_VOLUME_PRE (Message 3, Size 24)

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] Successfully launched (elevated privileges): svservice.exe message "Error from Manager "10.100.5.142" (error code 400):

                      Unable to locate the machine making this request on the hypervisor

                       

                       

                      Virtualization is disabled" (wait 0 ms), pid=4000 tid=2976

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] Successfully launched: svservice.exe message "Error from Manager "10.100.5.142" (error code 400):

                      Unable to locate the machine making this request on the hypervisor

                       

                       

                      Virtualization is disabled" (wait 0 ms)

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] HttpFileShareRequest WinHttp over SSL is disabled. Log collection to file share not supported.

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] handleFileShareStr: File share info received from manager is empty.

                      [2018-09-14 19:39:05.369 UTC] [svservice:P1104:T3444] OnStartShell: Error Failed to Start DCT Logger

                      [2018-09-14 19:39:05.415 UTC] [svservice:P4000:T2976] *** Started

                      [2018-09-14 20:05:02.213 UTC] [svservice:P1104:T5048] OnLock called (Session ID 1, Handle 000002915AE84DC0, Params 000000E6E0DFE9F8, Context 0000000000000000)

                      [2018-09-14 20:06:20.722 UTC] [svservice:P1104:T5052] OnUnlock called (Session ID 1, Handle 000002915AE84DC0, Params 000000E6E0EFE4F8, Context 0000000000000000)

                      • 8. Re: App Volumes not getting applied to instant clone
                        Ray_handels Master
                        Community WarriorsvExpert

                        Seems as if the VDI machine (and yes, you need to install the agent on the GI but you found that out already) cannot connect to the manager.

                        I'd suggest going for DNS names when you install the agent and it asks what manager to you, I think you need to do reverse DNS on it for it to work, not 100% sure though.

                        • 9. Re: App Volumes not getting applied to instant clone
                          JohnFLi Novice

                          got a little farther i think.

                          I changed useing the IP address to using the FQDN:

                           

                           

                          [2018-09-17 17:53:26.869 UTC] [svservice:P1136:T3440] ReadOutVolsFromString: NewVolumes 1 TotalVolumes 1

                          [2018-09-17 17:53:26.869 UTC] [svservice:P1136:T3440] ReadOutVolsFromString: Manager has asynchronous loading of volumes turned on

                          [2018-09-17 17:53:26.869 UTC] [svservice:P1136:T3440] ReadOutVolsFromString: volume path:"g1ptesx14-localstorage-1\cloudvolumes\apps\Notepad_7.5.8.vmdk" guid:"{1bf47220-e928-4ece-a1d7-c4a6aa9aaa1e}" type:"MOUNTED-READ"

                          [2018-09-17 17:53:26.869 UTC] [svservice:P1136:T3440] SvdPushReorderEntry: Sent reorder entry to filter {1bf47220-e928-4ece-a1d7-c4a6aa9aaa1e} (UserVolume: 1; Writable: 0)

                          [2018-09-17 17:53:26.869 UTC] [svservice:P1136:T3440] ReadOutVolsFromString: add AppStack to load order list:"{1bf47220-e928-4ece-a1d7-c4a6aa9aaa1e}"(1)

                          [2018-09-17 17:53:26.869 UTC] [svservice:P1136:T3440] ReadOutVolsFromString: invalid command:"ASYNC"

                          [2018-09-17 17:53:26.869 UTC] [svservice:P1136:T3440] LogonMount: agent:0 manager:1 volume(s) to attach

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] Activate filtering (called by WaitVolumesLoading)

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] WaitVolumesLoading: waiting for 1 total volume(s), 0 processed, max wait 180

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] WaitVolumesLoading: Wait for first volume only is 1

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] Releasing user logon, (Writable present: 0; Writable processed: 0)

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] SvdSetReorderCounter: set to 0

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] HttpUserLogin: succeeded (user login)

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] OnLogon : succeeded

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T1408] MeasureTime::RecordCenter: Start recording  GUID:{52877c63-0000-0000-0000-501f00000000} Type:0

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T1408] Preload volume event (startup): "\Device\HarddiskVolume2" GUID {52877c63-0000-0000-0000-501f00000000} Hive  (0 logged in, SystemVolume 1, VolumeType 0)

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T1408] Sending reply to SVCMD_ID_NEW_VOLUME_PRE (Message 3, Size 24)

                          [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T1860] WaitVolumesLoadingWorker: waiting for 1 total volume(s), 0 processed, max wait 180

                          [2018-09-17 17:53:27.916 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 1 second(s) so far)

                          [2018-09-17 17:53:28.932 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 2 second(s) so far)

                          [2018-09-17 17:53:29.947 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 3 second(s) so far)

                          [2018-09-17 17:53:30.963 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 4 second(s) so far)

                          [2018-09-17 17:53:31.979 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 5 second(s) so far)

                          [2018-09-17 17:53:32.338 UTC] [svservice:P1136:T3440] OnStartShell called (Session ID 1, Handle 0000029AB3D67D90, Params 000000F313EFE798, Context 0000000000000000)

                          [2018-09-17 17:53:32.338 UTC] [svservice:P1136:T3440] OnStartShell: <domain name edited here>\testuser.test (NameSamCompatible)

                          [2018-09-17 17:53:32.338 UTC] [svservice:P1136:T3440] HttpFileShareRequest WinHttp over SSL is disabled. Log collection to file share not supported.

                          [2018-09-17 17:53:32.338 UTC] [svservice:P1136:T3440] handleFileShareStr: File share info received from manager is empty.

                          [2018-09-17 17:53:32.338 UTC] [svservice:P1136:T3440] OnStartShell: Error Failed to Start DCT Logger

                          [2018-09-17 17:53:32.994 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 6 second(s) so far)

                          [2018-09-17 17:53:34.010 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 7 second(s) so far)

                          [2018-09-17 17:53:35.041 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 8 second(s) so far)

                          [2018-09-17 17:53:36.057 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 9 second(s) so far)

                          [2018-09-17 17:53:37.072 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 10 second(s) so far)

                          [2018-09-17 17:53:38.104 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 11 second(s) so far)

                          [2018-09-17 17:53:39.119 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 12 second(s) so far)

                          [2018-09-17 17:53:40.135 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 13 second(s) so far)

                          [2018-09-17 17:53:41.150 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 14 second(s) so far)

                          [2018-09-17 17:53:42.213 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 15 second(s) so far)

                          [2018-09-17 17:53:43.244 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 16 second(s) so far)

                          [2018-09-17 17:53:44.260 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 17 second(s) so far)

                          [2018-09-17 17:53:45.275 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 18 second(s) so far)

                          [2018-09-17 17:53:46.291 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 19 second(s) so far)

                          [2018-09-17 17:53:47.307 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 20 second(s) so far)

                          [2018-09-17 17:53:48.322 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 21 second(s) so far)

                          [2018-09-17 17:53:49.338 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 22 second(s) so far)

                          [2018-09-17 17:53:50.354 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 23 second(s) so far)

                          [2018-09-17 17:53:51.369 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 24 second(s) so far)

                          [2018-09-17 17:53:52.385 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 25 second(s) so far)

                          [2018-09-17 17:53:53.400 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 26 second(s) so far)

                          [2018-09-17 17:53:54.416 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 27 second(s) so far)

                          [2018-09-17 17:53:55.432 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 28 second(s) so far)

                          [2018-09-17 17:53:56.447 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 29 second(s) so far)

                          [2018-09-17 17:53:57.463 UTC] [svservice:P1136:T1860] Waiting for 1 new volumes before resetting order (0 processed, waited 30 second(s) so far)

                          [2018-09-17 17:53:57.463 UTC] [svservice:P1136:T1860] [0] Connecting to g1vtgbi02.<domain name edited here>.local:80 using HTTP (attempt 1)

                          [2018-09-17 17:53:57.463 UTC] [svservice:P1136:T1860] WinHttpSendRequestWithSSLCertValidation: SSL certificate validation is disabled.

                          [2018-09-17 17:53:57.463 UTC] [svservice:P1136:T1860] WinHttpSendRequestWithSSLCertValidation: WinHttpSetOption(WINHTTP_OPTION_SECURITY_FLAGS) succeeded.

                          [2018-09-17 17:53:57.525 UTC] [svservice:P1136:T1860] WinHttpSendRequestWithSSLCertValidation: WinHttpSendRequest succeeded.

                          [2018-09-17 17:53:57.525 UTC] [svservice:P1136:T1860] HttpReadAllAvailableData: Error 0 in WinHttpQueryDataAvailable: dwSize 0

                          [2018-09-17 17:53:57.525 UTC] [svservice:P1136:T1860] HttpInitializeRequest: Manager status 200 response (9 bytes): !FAILURE!

                          [2018-09-17 17:53:57.525 UTC] [svservice:P1136:T1860] SendMountConfirmationRequest: Volume mount-confirmation failed. Volumes will not be mounted.

                          • 10. Re: App Volumes not getting applied to instant clone
                            Ray_handels Master
                            Community WarriorsvExpert

                            Yes, i saw this in another thread as well. I do understand that you want this to be fixed but if possible please try and post in one thread and just point to this one (or vice versa off course ).

                             

                            When looking at the logging, these line means it can connect to the Appvolumes Manager. You can also see that because the manager reports that 1 appstack needs to be attached. So your connection from agent to manager is working.

                             

                            [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] HttpUserLogin: succeeded (user login)

                            [2018-09-17 17:53:26.900 UTC] [svservice:P1136:T3440] OnLogon : succeeded

                             

                            Looking at this line, it seems as if the manager says it cannot attach the appstack to the machine, it could be many reasons. Could you please try and check manager log to see why it does not attach?

                             

                            [2018-09-17 17:53:57.525 UTC] [svservice:P1136:T1860] HttpInitializeRequest: Manager status 200 response (9 bytes): !FAILURE!

                            [2018-09-17 17:53:57.525 UTC] [svservice:P1136:T1860] SendMountConfirmationRequest: Volume mount-confirmation failed. Volumes will not be mounted.

                             

                            Reasons I can think of is that the VDI cannot connect to the datastore the Appstacks are located on or the password for the VSphere manager is incorrect and it cannot connect to it.

                            The issue we had once is that certificate validation between Appvolumes manager and Vsphere was enabled and Vsphere did not have a trusted certificate. To check this go to Appvolumes Manager, then go to Configuration --> Machine Manager, open up the manager and to the right you should see a certificate option. It could be that you need to manually accept the untrusted certificate!!!.

                             

                            Also depending on the version, every time you restart appvolumes manager on Vsphere you need to re accept it.

                            • 11. Re: App Volumes not getting applied to instant clone
                              JohnFLi Novice

                              Sorry about posting in another spot.....I was just trying to expand my options.    I will keep it to this thread.

                               

                              This time when I logged into the clone (I say this time, because it does change from time to time) the error says:

                              "Error from Manager <FQDN on the manager machine>(error code 401) Invalid session cookie: Session key does not match any active sessions"

                               

                              Another message I get when trying is : "Error from Manager <FQDN on the manager machine>(error code 400) Unable to locate the machine making this request on the hypervisor"

                               

                              One thing I just noticed in one of the logs: " Establishing verified SSL connection to vSphere at "https://root@g1ptesx14.<domain name>.local" without certificate authorities due to missing file: "C:/Program Files (x86)/CloudVolumes/Manager/config/cacert.pem

                               

                              Here is a partial of production000005.log

                               

                              [2018-09-19 15:39:10 UTC]      P5080R5  INFO Started GET "/activity/system_messages" for 127.0.0.1 at 2018-09-19 08:39:10 -0700
                              [2018-09-19 15:39:10 UTC]      P5080R5  INFO Processing by ActivityController#system_messages as */*
                              [2018-09-19 15:39:10 UTC]      P5080R5  INFO  Referred by https://g1vtgbi02.<domain name>.local/activity?fresh=1537370585262 using Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)
                              [2018-09-19 15:39:10 UTC]      P5080R5  INFO Current Request roles: ["Administrators"], user: John username (Admin) (4)
                              [2018-09-19 15:39:10 UTC]      P5080R5  INFO   Rendered activity/system_messages.html.erb (0.0ms)
                              [2018-09-19 15:39:10 UTC]      P5080R5  INFO Completed 200 OK in 9ms (Views: 0.5ms | ActiveRecord: 4.0ms)
                              [2018-09-19 15:39:10 UTC]      P5080R5  INFO

                              [2018-09-19 15:39:10 UTC]       P556R7  INFO Started GET "/cv_api/system_messages?_=1537370585479" for 127.0.0.1 at 2018-09-19 08:39:10 -0700
                              [2018-09-19 15:39:10 UTC]       P556R7  INFO Processing by CvApi::SystemMessagesController#index as JSON
                              [2018-09-19 15:39:10 UTC]       P556R7  INFO   Parameters: {"_"=>"1537370585479"}
                              [2018-09-19 15:39:10 UTC]       P556R7  INFO  Referred by https://g1vtgbi02.<domain name>.local/activity?fresh=1537370585262 using Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 6.3; WOW64; Trident/7.0; .NET4.0E; .NET4.0C; .NET CLR 3.5.30729; .NET CLR 2.0.50727; .NET CLR 3.0.30729)
                              [2018-09-19 15:39:10 UTC]       P556R7  INFO Current Request roles: ["Administrators"], user: John username (Admin) (4)
                              [2018-09-19 15:39:11 UTC]       P556R7  INFO   Rendered cv_api/system_messages/index.jsonify (239.0ms)
                              [2018-09-19 15:39:11 UTC]       P556R7  INFO Completed 200 OK in 248ms (Views: 224.6ms | ActiveRecord: 19.0ms)
                              [2018-09-19 15:39:11 UTC]       P556R7  INFO

                              [2018-09-19 15:41:03 UTC]       P556R3  WARN    vCenter: Waited 180 seconds attempting to locate VM with IP "10.100.5.136" - giving up
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO        Cvo: Enqueue job: Find VM #<Thread:0x0000000004491a48>
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO        Cvo: Onlining "Computer <<domain name>\WIN10LTSB-003$>" with 13 previous login(s) - last login: 2018-09-19 15:26:51 UTC
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO        Cvo: "Computer <<domain name>\WIN10LTSB-003$>" is coming online on VM "" with ip:"10.100.5.136"
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO        Cvo: No machine provided to prepare_vm
                              [2018-09-19 15:41:03 UTC]       P556R3 ERROR   RvSphere: Fault in disable_background_vm_operations #<Thread:0x0000000004491a48> (exception NoMethodError): undefined method `identifier' for nil:NilClass
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO   RvSphere: Inspecting Array (22400640) (from log block)
                              [
                                  [0] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/vcenter_adapter.rb:260:in `block in disable_background_vm_operations'",
                                  [1] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/vcenter_adapter.rb:2290:in `block (2 levels) in connected_request'",
                                  [2] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/vcenter_adapter.rb:2283:in `block in with_retry'",
                                  [3] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/rv_sphere/error_handler.rb:40:in `with_retry'",
                                  [4] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/vcenter_adapter.rb:2282:in `with_retry'",
                                  [5] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/vcenter_adapter.rb:2289:in `block in connected_request'",
                                  [6] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/base_adapter.rb:859:in `block in connected_request'",
                                  [7] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/base_adapter.rb:823:in `catch_exceptions'",
                                  [8] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/base_adapter.rb:857:in `connected_request'",
                                  [9] "C:/Program Files (x86)/CloudVolumes/Manager/app/models/cvo/hypervisor/vcenter_adapter.rb:2288:in `connected_request'"
                              ]
                              [2018-09-19 15:41:03 UTC]       P556R3 ERROR        Cvo: Failed to disable vMotion: undefined method `identifier' for nil:NilClass
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO        Cvo: Unsuccessful mount result appended to response: Volumes were not mounted due to an error on the server. Please try logging in again, or contact your administrator.
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO   Rendered text template (0.0ms)
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO Completed 400 Bad Request in 185580ms (Views: 0.7ms | ActiveRecord: 179.3ms)
                              [2018-09-19 15:41:03 UTC]       P556R3  INFO

                              [2018-09-19 15:41:05 UTC]  P2980DJ2877  INFO 2018-09-19T08:41:05-0700: [Worker(host:G1VTGBI02 pid:2980)] Job FindComputerVmJob#perform (id=2878) RUNNING
                              [2018-09-19 15:41:05 UTC]  P2980DJ2878  INFO        Cvo: Starting job: Find VM #<Thread:0x0000000000a3bf38>
                              [2018-09-19 15:41:05 UTC]  P2980DJ2878  INFO        Cvo: Hypervisor Pool: Acquired 'esx' adapter 1 of 25 for 'esx-334910699' in 0.0 seconds
                              [2018-09-19 15:41:05 UTC]  P2980DJ2878  INFO   RvSphere: Connecting to vSphere "root@g1ptesx14.<domain name>.local" on "#<Thread:0x0000000000a3bf38>"
                              [2018-09-19 15:41:05 UTC]  P2980DJ2878  INFO   RvSphere: Establishing verified SSL connection to vSphere at "https://root@g1ptesx14.<domain name>.local" without certificate authorities due to missing file: "C:/Program Files (x86)/CloudVolumes/Manager/config/cacert.pem"
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO        Cvo: Validating SSL certificate for "g1ptesx14.<domain name>.local": Trusted by an administrator
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO        Cvo: Validated SSL certificate for "g1ptesx14.<domain name>.local". Validation Result = true, Validation Status = 2.
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO        Cvo: Size of AVM SSL Fingerprint cache is 1
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO        Cvo: Size of AVM SSL Fingerprint cache is 1
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO        Cvo: Size of AVM SSL Fingerprint cache is 1
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO   RvSphere: Connection to vSphere at "root@g1ptesx14.<domain name>.local" on "#<Thread:0x0000000000a3bf38>" was successful and took 1269.8ms
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO   RvSphere: vSphere Server: "VMware ESXi 6.0.0 build-5224934" Instance: "" License: "VMware ESX Server"
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO        Cvo: Size of the AVM SSL Fingerprint cache is 0
                              [2018-09-19 15:41:06 UTC]  P2980DJ2878  INFO    vCenter: Unable to find a VM by the provided vmpath "/TestDev/vm/Win10 Virtual Desktop v2/17Sept2018/Win10LTSB-003"

                               

                              • 12. Re: App Volumes not getting applied to instant clone
                                Ray_handels Master
                                vExpertCommunity Warriors

                                I'm sorry but I'm at a loss. Installing it here was very straightforward and attaching appstacks was really easy but I can't seem to find what is going on there in your environment without looking at it more closely.

                                Cvo: Unsuccessful mount result appended to response: Volumes were not mounted due to an error on the server. Please try logging in again, or contact your administrator.

                                 

                                For me it seems as it there is something wrong with the VMWare ESx but that's about as much as I can say. Maybe someone else has an idea??

                                • 13. Re: App Volumes not getting applied to instant clone
                                  JohnFLi Novice

                                  It's probably why support doesn't want to touch it.   lol

                                   

                                  One thing that I did try and was able to do.....

                                   

                                  On the provisioning machine (after going back to a snapshot before installing an app), i was able to attach the appstack.   its very nice when it does work at least.

                                  • 14. Re: App Volumes not getting applied to instant clone
                                    Ray_handels Master
                                    Community WarriorsvExpert

                                    I'd suggest trying to rebuild the environment and (if you did not do this before) use the manual step by step,

                                    To be honest it is quite straight forward the installation of Appvolumes itself.

                                    You just install the manager, set up AD, vsphere and a database, upload templates, create an appstack and just assign it. After that it does get a little bit more complicated. It's kinda like easy to learn hard to master.