[
https://issues.apache.org/jira/browse/CLOUDSTACK-5016?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Ram Ganesh updated CLOUDSTACK-5016:
-----------------------------------
Assignee: Likitha Shetty
> Failed to reboot the VM which has VM Snapshots and Migrated Volumes
> -------------------------------------------------------------------
>
> Key: CLOUDSTACK-5016
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-5016
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the
> default.)
> Components: Storage Controller, VMware
> Affects Versions: 4.2.1
> Reporter: Sailaja Mada
> Assignee: Likitha Shetty
> Priority: Critical
> Fix For: 4.2.1
>
> Attachments: logsall.rar, startvm.png
>
>
> Steps:
> 1. Configure Adv Zone with 2 zone wide primary storages using VMWARE 5.0
> update2 Hypervisor
> 2. Deploy VM using user account
> 3. Create 2 VMsnapshots wo memory and 1 VM snapshot with Memory
> 4. Revert to VM Snap2 then to VM Snap1
> 5. Stop the VM and Migrate the Volume to second Primary Storage
> 7. Start the VM - It got started.
> 8. Tried to reboot the VM.
> Observation:
> It failed to start the VM .
> 2013-10-31 20:17:28,495 WARN [storage.resource.VmwareStorageLayoutHelper]
> (DirectAgent-289:10.102.192.18) Unable to locate VMDK file:
> a933eb3fa28a473ab5e28b99f5f2607e-delta.vmdk
> 2013-10-31 20:17:28,496 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-289:null) Seq 9-894174187: Response Received:
> 2013-10-31 20:17:28,497 DEBUG [agent.transport.Request]
> (DirectAgent-289:null) Seq 9-894174187: Processing: { Ans: , MgmtId:
> 94838926819810, via: 9, Ver: v1, Flags: 10,
> [{"com.cloud.agent.api.Answer":{"result":true,"details":"Success","wait":0}}]
> }
> 2013-10-31 20:17:28,497 DEBUG [agent.transport.Request]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Seq
> 9-894174187: Received: { Ans: , MgmtId: 94838926819810, via: 9, Ver: v1,
> Flags: 10, { Answer } }
> 2013-10-31 20:17:28,507 INFO [storage.volume.VolumeServiceImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Volume 39
> is not referred anywhere, remove it from volumes table
> 2013-10-31 20:17:28,513 ERROR [cloud.storage.VolumeManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) migrate
> volume failed:copy volume from primary to secondary failed due to exception:
> Exception: java.lang.RuntimeException
> Message: File [7f18caf5397a340a934ed37c558aee2b] i-5-24-VM/i-5-24-VM.vmx was
> not found
> 2013-10-31 20:17:28,519 INFO [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Unable to
> contact resource.
> com.cloud.exception.StorageUnavailableException: Resource [StoragePool:5] is
> unreachable: migrate volume failed: copy volume from primary to secondary
> failed due to exception: Exception: java.lang.RuntimeException
> Message: File [7f18caf5397a340a934ed37c558aee2b] i-5-24-VM/i-5-24-VM.vmx was
> not found
> 2013-10-31 20:17:28,519 INFO [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Unable to
> contact resource.
> com.cloud.exception.StorageUnavailableException: Resource [StoragePool:5] is
> unreachable: migrate volume failed: copy volume from primary to secondary
> failed due to exception: Exception: java.lang.RuntimeException
> Message: File [7f18caf5397a340a934ed37c558aee2b] i-5-24-VM/i-5-24-VM.vmx was
> not found
> at
> com.cloud.storage.VolumeManagerImpl.migrateVolume(VolumeManagerImpl.java:2278)
> at
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at
> com.cloud.storage.VolumeManagerImpl.prepare(VolumeManagerImpl.java:2629)
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:888)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:577)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:570)
> at
> com.cloud.vm.UserVmManagerImpl.restoreVMInternal(UserVmManagerImpl.java:4930)
> at
> com.cloud.vm.UserVmManagerImpl.rebootVirtualMachine(UserVmManagerImpl.java:1971)
> at
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at
> org.apache.cloudstack.api.command.user.vm.RebootVMCmd.execute(RebootVMCmd.java:99)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at
> com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
> at java.lang.Thread.run(Thread.java:679)
> 2013-10-31 20:17:28,547 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Cleaning
> up resources for the vm VM[User|sailajaVM1] in Starting state
> 2013-10-31 20:17:28,549 DEBUG [agent.transport.Request]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Seq
> 9-894174188: Sending { Cmd , MgmtId: 94838926819810, via: 9, Ver: v1, Flags:
> 100111,
> [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"i-5-24-VM","wait":0}}]
> }
> 2013-10-31 20:17:28,549 DEBUG [agent.transport.Request]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Seq
> 9-894174188: Executing: { Cmd , MgmtId: 94838926819810, via: 9, Ver: v1,
> Flags: 100111,
> [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"i-5-24-VM","wait":0}}]
> }
> 2013-10-31 20:17:28,853 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) release
> mem from host: 9, old used: 2013265920,reserved: 0, total: 17166258176; new
> used: 1476395008,reserved:0; movedfromreserved: false,moveToReserveredfalse
> 2013-10-31 20:17:28,881 DEBUG [cloud.vm.UserVmManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Unable to
> start VM 1ec83c40-e0dc-48ad-90d8-f4000c0dfe91
> com.cloud.exception.InsufficientServerCapacityException: Unable to create a
> deployment for VM[User|sailajaVM1]Scope=interface com.cloud.dc.DataCenter;
> id=4
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:841)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:577)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:570)
> at
> com.cloud.vm.UserVmManagerImpl.restoreVMInternal(UserVmManagerImpl.java:4930)
> at
> com.cloud.vm.UserVmManagerImpl.rebootVirtualMachine(UserVmManagerImpl.java:1971)
> at
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at
> org.apache.cloudstack.api.command.user.vm.RebootVMCmd.execute(RebootVMCmd.java:99)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at
> com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
> at java.lang.Thread.run(Thread.java:679)
> 2013-10-31 20:17:28,889 ERROR [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ])
> Unexpected exception while executing
> org.apache.cloudstack.api.command.user.vm.RebootVMCmd
> com.cloud.utils.exception.CloudRuntimeException: Unable to start VM with
> specified idUnable to create a deployment for VM[User|sailajaVM1]
> at
> com.cloud.vm.UserVmManagerImpl.restoreVMInternal(UserVmManagerImpl.java:4933)
> at
> com.cloud.vm.UserVmManagerImpl.rebootVirtualMachine(UserVmManagerImpl.java:1971)
> at
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at
> org.apache.cloudstack.api.command.user.vm.RebootVMCmd.execute(RebootVMCmd.java:99)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at
> com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
> at java.lang.Thread.run(Thread.java:679)
> 2013-10-31 20:17:28,891 DEBUG [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-5:job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ]) Complete
> async job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038 ], jobStatus: 2,
> resultCode: 530, result: Error Code: 530 Error text: Unable to start VM with
> specified idUnable to create a deployment for VM[User|sailajaVM1]
> 2013-10-31 20:17:30,404 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null)
> ===START=== 10.104.255.45 -- GET
> command=queryAsyncJobResult&jobId=57e484cb-c0aa-47c8-b991-1aa7aed9b038&response=json&sessionkey=CHP8%2Bg6QICbqOnSaFI0Tkhq5ngs%3D&_=1383231183604
> 2013-10-31 20:17:30,417 DEBUG [cloud.async.AsyncJobManagerImpl]
> (catalina-exec-2:null) Async job-143 = [ 57e484cb-c0aa-47c8-b991-1aa7aed9b038
> ] completed
> 2013-10-31 20:17:28,549 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-228:null) Seq 9-894174188: Executing request
> 2013-10-31 20:17:28,549 INFO [vmware.resource.VmwareResource]
> (DirectAgent-228:10.102.192.18) Executing resource StopCommand:
> {"isProxy":false,"executeInSequence":true,"vmName":"i-5-24-VM","wait":0}
--
This message was sent by Atlassian JIRA
(v6.1#6144)
