Chandan Purushothama created CLOUDSTACK-3677:
------------------------------------------------
Summary: VMSnapshot on XenServer: RevertToVMSnapshot failed to
revert VM to Snapshot
Key: CLOUDSTACK-3677
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3677
Project: CloudStack
Issue Type: Bug
Security Level: Public (Anyone can view this level - this is the default.)
Components: Management Server
Affects Versions: 4.2.0
Reporter: Chandan Purushothama
Priority: Critical
Fix For: 4.2.0
Setup: Advanced Zone, XenServer 6.2
=================
Steps to Reproduce:
=================
1. Deploy Vm. Attach muiltiple data disks to this VM.
2. Log in to the Vm and create few directories and files on the root volume.
Create few more directories on each of the data disks.
3. Stop the VM. Create VMSnapshot for this VM with "vm_snapshot_type" set to
"Disk".
4. Revert to the VMSnapshot and observe the failure
====================
Management Server Log:
====================
2013-07-19 13:50:52,918 DEBUG [cloud.api.ApiServlet] (catalina-exec-20:null)
===START=== 10.252.121.104 -- GET
command=revertToVMSnapshot&vmsnapshotid=b7832d89-de57-4f94-b1e9-a93e7975ef0e&response=json&sessionkey=UXTrrcPGpFO1xH15V%2FhI8SByX1c%3D&_=1374267435422
2013-07-19 13:50:52,943 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-20:null) submit async job-45 = [
e8ffdd72-0c4d-4b47-8106-7181b54ac06c ], details: AsyncJobVO {id:45, userId: 4,
accountId: 4, sessionKey: null, instanceType: None, instanceId: null, cmd:
org.apache.cloudstack.api.command.user.vmsnapshot.RevertToVMSnapshotCmd,
cmdOriginator: null, cmdInfo:
{"response":"json","sessionkey":"UXTrrcPGpFO1xH15V/hI8SByX1c\u003d","cmdEventType":"VMSNAPSHOT.REVERTTO","ctxUserId":"4","httpmethod":"GET","_":"1374267435422","vmsnapshotid":"b7832d89-de57-4f94-b1e9-a93e7975ef0e","ctxAccountId":"4","ctxStartEventId":"192"},
cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0,
processStatus: 0, resultCode: 0, result: null, initMsid: 7471666038533,
completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2013-07-19 13:50:52,945 DEBUG [cloud.api.ApiServlet] (catalina-exec-20:null)
===END=== 10.252.121.104 -- GET
command=revertToVMSnapshot&vmsnapshotid=b7832d89-de57-4f94-b1e9-a93e7975ef0e&response=json&sessionkey=UXTrrcPGpFO1xH15V%2FhI8SByX1c%3D&_=1374267435422
2013-07-19 13:50:52,947 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-30:job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Executing
org.apache.cloudstack.api.command.user.vmsnapshot.RevertToVMSnapshotCmd for
job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]
2013-07-19 13:50:52,966 DEBUG [cloud.user.AccountManagerImpl]
(Job-Executor-30:job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Access to
com.cloud.vm.snapshot.VMSnapshotVO$$EnhancerByCGLIB$$956acea7@7ece4609 granted
to Acct[4-atoms] by DomainChecker_EnhancerByCloudStack_2fa3ef51
2013-07-19 13:50:52,985 DEBUG [agent.transport.Request] (Job-Executor-30:job-45
= [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Seq 4-110170392: Sending { Cmd ,
MgmtId: 7471666038533, via: 4, Ver: v1, Flags: 100011,
[{"com.cloud.agent.api.RevertToVMSnapshotCommand":{"volumeTOs":[{"id":13,"name":"New
Volume
1","path":"67e644ac-5792-4007-9eb6-ac298e0c42f3","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"5a0dfa0c-0476-3013-8bb2-a140e3f467c2","deviceId":2},{"id":14,"name":"ROOT-11","path":"374a56ac-19a1-4885-8a95-51142be064c1","size":8589934592,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"5a0dfa0c-0476-3013-8bb2-a140e3f467c2","deviceId":0},{"id":15,"name":"DATA-11","path":"5c0d41f7-dcab-4a51-aaa8-36729fb4c338","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"5a0dfa0c-0476-3013-8bb2-a140e3f467c2","deviceId":1}],"target":{"id":4,"snapshotName":"i-4-11-VMSNAPSHOT_VS_20130719203659","type":"Disk","createTime":1374266220000,"current":false,"description":"VM-Snapshot-5"},"vmName":"i-4-11-VMSNAPSHOT","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-07-19 13:50:52,986 DEBUG [agent.transport.Request] (Job-Executor-30:job-45
= [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Seq 4-110170392: Executing: { Cmd
, MgmtId: 7471666038533, via: 4, Ver: v1, Flags: 100011,
[{"com.cloud.agent.api.RevertToVMSnapshotCommand":{"volumeTOs":[{"id":13,"name":"New
Volume
1","path":"67e644ac-5792-4007-9eb6-ac298e0c42f3","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"5a0dfa0c-0476-3013-8bb2-a140e3f467c2","deviceId":2},{"id":14,"name":"ROOT-11","path":"374a56ac-19a1-4885-8a95-51142be064c1","size":8589934592,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"5a0dfa0c-0476-3013-8bb2-a140e3f467c2","deviceId":0},{"id":15,"name":"DATA-11","path":"5c0d41f7-dcab-4a51-aaa8-36729fb4c338","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"5a0dfa0c-0476-3013-8bb2-a140e3f467c2","deviceId":1}],"target":{"id":4,"snapshotName":"i-4-11-VMSNAPSHOT_VS_20130719203659","type":"Disk","createTime":1374266220000,"current":false,"description":"VM-Snapshot-5"},"vmName":"i-4-11-VMSNAPSHOT","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-07-19 13:50:52,986 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-36:null) Seq 4-110170392: Executing request
2013-07-19 13:50:53,136 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-418:null) Seq 4-110166020: Executing request
2013-07-19 13:50:53,401 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-418:null) Seq 4-110166020: Response Received:
2013-07-19 13:50:53,401 DEBUG [agent.transport.Request] (DirectAgent-418:null)
Seq 4-110166020: Processing: { Ans: , MgmtId: 7471666038533, via: 4, Ver: v1,
Flags: 10,
[{"com.cloud.agent.api.ClusterSyncAnswer":{"_clusterId":2,"_newStates":{},"_isExecuted":false,"result":true,"wait":0}}]
}
2013-07-19 13:50:55,137 ERROR [xen.resource.CitrixResourceBase]
(DirectAgent-36:null) revert vm i-4-11-VMSNAPSHOT to snapshot
i-4-11-VMSNAPSHOT_VS_20130719203659 failed due to null
2013-07-19 13:50:55,137 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-36:null) Seq 4-110170392: Response Received:
2013-07-19 13:50:55,138 DEBUG [agent.transport.Request] (DirectAgent-36:null)
Seq 4-110170392: Processing: { Ans: , MgmtId: 7471666038533, via: 4, Ver: v1,
Flags: 10,
[{"com.cloud.agent.api.RevertToVMSnapshotAnswer":{"result":false,"wait":0}}] }
2013-07-19 13:50:55,138 DEBUG [agent.transport.Request] (Job-Executor-30:job-45
= [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Seq 4-110170392: Received: { Ans:
, MgmtId: 7471666038533, via: 4, Ver: v1, Flags: 10, { RevertToVMSnapshotAnswer
} }
2013-07-19 13:50:55,138 ERROR [vm.snapshot.VMSnapshotManagerImpl]
(Job-Executor-30:job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Revert VM:
i-4-11-VMSNAPSHOT to snapshot: i-4-11-VMSNAPSHOT_VS_20130719203659 failed
2013-07-19 13:50:55,144 ERROR [vm.snapshot.VMSnapshotManagerImpl]
(Job-Executor-30:job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) revert vm:
i-4-11-VMSNAPSHOT to snapshot i-4-11-VMSNAPSHOT_VS_20130719203659 failed due to
Revert VM: i-4-11-VMSNAPSHOT to snapshot: i-4-11-VMSNAPSHOT_VS_20130719203659
failed
2013-07-19 13:50:55,152 ERROR [cloud.async.AsyncJobManagerImpl]
(Job-Executor-30:job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Unexpected
exception while executing
org.apache.cloudstack.api.command.user.vmsnapshot.RevertToVMSnapshotCmd
com.cloud.utils.exception.CloudRuntimeException: Revert VM: i-4-11-VMSNAPSHOT
to snapshot: i-4-11-VMSNAPSHOT_VS_20130719203659 failed
at
com.cloud.vm.snapshot.VMSnapshotManagerImpl.revertInternal(VMSnapshotManagerImpl.java:747)
at
com.cloud.vm.snapshot.VMSnapshotManagerImpl.revertToSnapshot(VMSnapshotManagerImpl.java:707)
at
com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
at
org.apache.cloudstack.api.command.user.vmsnapshot.RevertToVMSnapshotCmd.execute(RevertToVMSnapshotCmd.java:71)
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-07-19 13:50:55,154 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-30:job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ]) Complete
async job-45 = [ e8ffdd72-0c4d-4b47-8106-7181b54ac06c ], jobStatus: 2,
resultCode: 530, result: Error Code: 530 Error text: Revert VM:
i-4-11-VMSNAPSHOT to snapshot: i-4-11-VMSNAPSHOT_VS_20130719203659 failed
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira
