δΊ 2013/5/21 17:49, Tal Nisan ει:
Hi,
Can you please send the engine log so we'll be able to understand
better what failed?
Also are there any event logs in the event tab that indicate a
failure? (Marked with a red X icon)
Tal.
On 05/21/2013 12:45 PM, lof yer wrote:
> I created a VM, and started it in stateless mode. Then I shut it
> down, and I can not started it again...
I got an error like this on starting it:
Failed to start VM st1, because exist snapshot for stateless state.
Snapshot will be deleted.
And here's my log:
2013-05-21 19:22:10,275 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(ajp--127.0.0.1-8702-5) [4e43f020] Lock Acquired to object EngineLock
[exclusiveLocks= key: b4700f69-6e1d-404d-97d7-a75590adf52c value: VM
, sharedLocks= ]
2013-05-21 19:22:10,307 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
(ajp--127.0.0.1-8702-5) [4e43f020] START,
IsVmDuringInitiatingVDSCommand( vmId =
b4700f69-6e1d-404d-97d7-a75590adf52c), log id: 584624d7
2013-05-21 19:22:10,308 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
(ajp--127.0.0.1-8702-5) [4e43f020] FINISH,
IsVmDuringInitiatingVDSCommand, return: false, log id: 584624d7
2013-05-21 19:22:10,374 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(pool-5-thread-48) [4e43f020] Running command: RunVmCommand internal:
false. Entities affected : ID: b4700f69-6e1d-404d-97d7-a75590adf52c Type: VM
2013-05-21 19:22:10,385 INFO [org.ovirt.engine.core.bll.VmPoolHandler]
(pool-5-thread-48) [4e43f020] VdcBll.VmPoolHandler.ProcessVmPoolOnStopVm
- Deleting snapshot for stateless vm b4700f69-6e1d-404d-97d7-a75590adf52c
2013-05-21 19:22:10,441 INFO
[org.ovirt.engine.core.bll.RestoreStatelessVmCommand] (pool-5-thread-48)
[4e43f020] Running command: RestoreStatelessVmCommand internal: true.
Entities affected : ID: b4700f69-6e1d-404d-97d7-a75590adf52c Type: VM
2013-05-21 19:22:10,469 INFO
[org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand]
(pool-5-thread-48) [4e43f020] Running command:
RestoreAllSnapshotsCommand internal: true. Entities affected : ID:
b4700f69-6e1d-404d-97d7-a75590adf52c Type: VM
2013-05-21 19:22:10,469 INFO
[org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand]
(pool-5-thread-48) [4e43f020] Locking VM(id =
b4700f69-6e1d-404d-97d7-a75590adf52c) without compensation.
2013-05-21 19:22:10,471 INFO
[org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand]
(pool-5-thread-48) [4e43f020] START, SetVmStatusVDSCommand( vmId =
b4700f69-6e1d-404d-97d7-a75590adf52c, status = ImageLocked), log id:
2efbbe9c
2013-05-21 19:22:10,473 INFO
[org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand]
(pool-5-thread-48) [4e43f020] FINISH, SetVmStatusVDSCommand, log id:
2efbbe9c
2013-05-21 19:22:10,651 ERROR
[org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand]
(pool-5-thread-48) [4e43f020] Command
org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand throw exception:
java.lang.NullPointerException
at
org.ovirt.engine.core.bll.snapshots.SnapshotsManager.removeDisksNotInSnapshot(SnapshotsManager.java:412)
[bll.jar:]
at
org.ovirt.engine.core.bll.snapshots.SnapshotsManager.synchronizeDisksFromSnapshot(SnapshotsManager.java:399)
[bll.jar:]
at
org.ovirt.engine.core.bll.snapshots.SnapshotsManager.attempToRestoreVmConfigurationFromSnapshot(SnapshotsManager.java:248)
[bll.jar:]
at
org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand.restoreConfiguration(RestoreAllSnapshotsCommand.java:225)
[bll.jar:]
at
org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand.restoreSnapshotAndRemoveObsoleteSnapshots(RestoreAllSnapshotsCommand.java:193)
[bll.jar:]
at
org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand.executeVmCommand(RestoreAllSnapshotsCommand.java:97)
[bll.jar:]
at org.ovirt.engine.core.bll.VmCommand.executeCommand(VmCommand.java:80)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1063)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1148)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1618)
[bll.jar:]
at
org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInRequired(TransactionSupport.java:151)
[utils.jar:]
at
org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:118)
[utils.jar:]
at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1166)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:318) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:332)
[bll.jar:]
at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:534)
[bll.jar:]
at sun.reflect.GeneratedMethodAccessor119.invoke(Unknown Source) [:1.7.0_19]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.7.0_19]
at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_19]
at
org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInCallerTx(CMTTxInterceptor.java:202)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:365)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view9.runInternalAction(Unknown
Source) [bll.jar:]
at
org.ovirt.engine.core.bll.RestoreStatelessVmCommand.executeCommand(RestoreStatelessVmCommand.java:48)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1063)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1148)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1618)
[bll.jar:]
at
org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInNewTransaction(TransactionSupport.java:210)
[utils.jar:]
at
org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInRequired(TransactionSupport.java:149)
[utils.jar:]
at
org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:118)
[utils.jar:]
at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1166)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:318) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:332)
[bll.jar:]
at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:534)
[bll.jar:]
at sun.reflect.GeneratedMethodAccessor119.invoke(Unknown Source) [:1.7.0_19]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.7.0_19]
at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_19]
at
org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59)
[jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
[jboss-invocation.jar:1.1.1.Final]
at
org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72)
[jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at
org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view9.runInternalAction(Unknown
Source) [bll.jar:]
at
org.ovirt.engine.core.bll.VmPoolHandler.removeVmStatelessImages(VmPoolHandler.java:58)
[bll.jar:]
at
org.ovirt.engine.core.bll.VmPoolHandler.ProcessVmPoolOnStopVm(VmPoolHandler.java:48)
[bll.jar:]
at
org.ovirt.engine.core.bll.RunVmCommand.removeVmStatlessImages(RunVmCommand.java:398)
[bll.jar:]
at
org.ovirt.engine.core.bll.RunVmCommand.executeVmCommand(RunVmCommand.java:272)
[bll.jar:]
at org.ovirt.engine.core.bll.VmCommand.executeCommand(VmCommand.java:80)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1063)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1148)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1618)
[bll.jar:]
at
org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174)
[utils.jar:]
at
org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116)
[utils.jar:]
at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1166)
[bll.jar:]
at
org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:318) [bll.jar:]
at
org.ovirt.engine.core.bll.MultipleActionsRunner.executeValidatedCommand(MultipleActionsRunner.java:174)
[bll.jar:]
at
org.ovirt.engine.core.bll.MultipleActionsRunner.RunCommands(MultipleActionsRunner.java:156)
[bll.jar:]
at
org.ovirt.engine.core.bll.SortedMultipleActionsRunnerBase.RunCommands(SortedMultipleActionsRunnerBase.java:17)
[bll.jar:]
at
org.ovirt.engine.core.bll.MultipleActionsRunner$1.run(MultipleActionsRunner.java:94)
[bll.jar:]
at
org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:71)
[utils.jar:]
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
[rt.jar:1.7.0_19]
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
[rt.jar:1.7.0_19]
at java.util.concurrent.FutureTask.run(FutureTask.java:166)
[rt.jar:1.7.0_19]
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[rt.jar:1.7.0_19]
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[rt.jar:1.7.0_19]
at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_19]
2013-05-21 19:22:10,681 INFO
[org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand]
(pool-5-thread-48) [4e43f020] Lock freed to object EngineLock
[exclusiveLocks= key: b4700f69-6e1d-404d-97d7-a75590adf52c value: VM
, sharedLocks= ]
2013-05-21 19:22:10,683 ERROR
[org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand]
(pool-5-thread-48) [4e43f020] Transaction rolled-back for command:
org.ovirt.engine.core.bll.RestoreAllSnapshotsCommand.
2013-05-21 19:22:10,683 ERROR
[org.ovirt.engine.core.bll.RestoreStatelessVmCommand] (pool-5-thread-48)
[4e43f020] Transaction rolled-back for command:
org.ovirt.engine.core.bll.RestoreStatelessVmCommand.
2013-05-21 19:22:10,696 WARN
[org.ovirt.engine.core.bll.lock.InMemoryLockManager] (pool-5-thread-48)
[4e43f020] Trying to release exclusive lock which does not exist, lock
key: b4700f69-6e1d-404d-97d7-a75590adf52cVM
2013-05-21 19:22:10,697 INFO
[org.ovirt.engine.core.bll.RestoreStatelessVmCommand] (pool-5-thread-48)
[4e43f020] Lock freed to object EngineLock [exclusiveLocks= key:
b4700f69-6e1d-404d-97d7-a75590adf52c value: VM
, sharedLocks= ]