Created attachment 581656 [details] log Description of problem: if migration is initiated by the system we are not logging the migration in the task manager Version-Release number of selected component (if applicable): si2.1 How reproducible: 100% Steps to Reproduce: 1. run vm on spm in two hosts cluster 2. block connectivity to storage from spm using iptables 3. Actual results: the vm's will migrate but migration will not be logged in the task manager Expected results: vm migration should appear in the task manager Additional info: log
VdsEventListener.vdsNonOperational does not create a Job context for running the internal command. As a result, the created step of migrate does not have an associated job. This context should be propagated via MigrateAllVms to the step creation.
In addition, the exception logging at private ExecutionContext createMigrateVmContext(VM vm) } catch (RuntimeException e) { log.error(e); } Should be improved (MaintananceVdsCommand.java)
http://gerrit.ovirt.org/#/c/6148/
fixed in commit : 4d19328
MigrateAllVms throws exception (bug: 844344). although vm migrates we see no task created in the task manager log. will attach full log 2012-07-30 14:10:03,451 ERROR [org.ovirt.engine.core.bll.MaintananceVdsCommand] (pool-4-thread-45) [1ef354a5] Failed to create ExecutionContext for MigrateVmCommand: java.lang.NullPointerException at org.ovirt.engine.core.bll.MaintananceVdsCommand.createMigrateVmContext(MaintananceVdsCommand.java:117) [engine-bll.jar:] at org.ovirt.engine.core.bll.MaintananceVdsCommand.MigrateAllVms(MaintananceVdsCommand.java:96) [engine-bll.jar:] at org.ovirt.engine.core.bll.MaintananceVdsCommand.MigrateAllVms(MaintananceVdsCommand.java:82) [engine-bll.jar:] at org.ovirt.engine.core.bll.SetNonOperationalVdsCommand$1.run(SetNonOperationalVdsCommand.java:44) [engine-bll.jar:] at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:64) [engine-utils.jar:] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_05-icedtea] at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_05-icedtea] at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_05-icedtea] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110) [rt.jar:1.7.0_05-icedtea] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603) [rt.jar:1.7.0_05-icedtea] at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_05-icedtea] 2012-07-30 15:10:09,317 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateBrokerVDSCommand] (pool-4-thread-45) [30642514] VdsBroker::migrate::Entered (vm_guid=fc52981c-8271-42dc-97ab-40aae2f6bd37, srcHost=orange-vdsd.qa.lab.tlv.re dhat.com, dstHost=blond-vdsh.qa.lab.tlv.redhat.com:54321, method=online 2012-07-30 15:10:09,317 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateBrokerVDSCommand] (pool-4-thread-45) [30642514] START, MigrateBrokerVDSCommand(vdsId = 8fdfe32c-d96e-11e1-a853-001a4a169741, vmId=fc52981c-8271-42dc-97ab-40 aae2f6bd37, srcHost=orange-vdsd.qa.lab.tlv.redhat.com, dstVdsId=85a0068a-d96e-11e1-af1e-001a4a169741, dstHost=blond-vdsh.qa.lab.tlv.redhat.com:54321, migrationMethod=ONLINE), log id: 3b8992c5 2012-07-30 15:10:09,341 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateBrokerVDSCommand] (pool-4-thread-45) [30642514] FINISH, MigrateBrokerVDSCommand, log id: 3b8992c5 2012-07-30 15:10:09,403 INFO [org.ovirt.engine.core.vdsbroker.MigrateVDSCommand] (pool-4-thread-45) [30642514] FINISH, MigrateVDSCommand, return: MigratingFrom, log id: 53617cea 2012-07-30 15:10:11,073 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-59) [4cd67a82] hostFromVds::selectedVds - blond-vdsh, spmStatus Free, storage pool iSCSI 2012-07-30 15:10:11,104 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-59) [4cd67a82] SpmStatus on vds 8fdfe32c-d96e-11e1-a853-001a4a169741: Unknown_Pool 2012-07-30 15:10:11,119 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-59) [4cd67a82] starting spm on vds blond-vdsh, storage pool iSCSI, prevId 2, LVER 5 2012-07-30 15:10:11,120 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (QuartzScheduler_Worker-59) [4cd67a82] START, SpmStartVDSCommand(vdsId = 85a0068a-d96e-11e1-af1e-001a4a169741, storagePoolId = b421b191-d2ec-4c b0-a8e5-751be6cbaa43, prevId=2, prevLVER=5, storagePoolFormatType=V3, recoveryMode=Manual, SCSIFencing=false), log id: 6ca8debe 2012-07-30 15:10:11,149 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (QuartzScheduler_Worker-59) [4cd67a82] spmStart polling started: taskId = d945be39-f653-44d4-b2ad-d7da566f259f 2012-07-30 15:10:11,729 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-76) [337526ca] vds::refreshVmList vm id fc52981c-8271-42dc-97ab-40aae2f6bd37 is migrating to vds blond-vdsh ignoring it in the refresh till migration is done 2012-07-30 15:10:11,730 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-76) [337526ca] vds::refreshVmList vm id ef15de06-95be-4556-90ac-1c292f649285 is migrating to vds blond-vdsh ignoring it in the refresh till migration is done 2012-07-30 15:10:13,800 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-44) [46fe0ef] vds::refreshVmList vm id fc52981c-8271-42dc-97ab-40aae2f6bd37 is migrating to vds blond-vdsh ignoring it in the r efresh till migration is done 2012-07-30 15:10:13,801 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-44) [46fe0ef] vds::refreshVmList vm id ef15de06-95be-4556-90ac-1c292f649285 is migrating to vds blond-vdsh ignoring it in the r efresh till migration is done 2012-07-30 15:10:15,871 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-70) [23bd2346] vds::refreshVmList vm id fc52981c-8271-42dc-97ab-40aae2f6bd37 is migrating to vds blond-vdsh ignoring it in the refresh till migration is done 2012-07-30 15:10:15,872 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-70) [23bd2346] vds::refreshVmList vm id ef15de06-95be-4556-90ac-1c292f649285 is migrating to vds blond-vdsh ignoring it in the refresh till migration is done
Created attachment 601240 [details] engine log
(In reply to comment #5) Are you checking BZ 844344 scenario here? Please check with the original scenario described in this bug
(In reply to comment #7) > (In reply to comment #5) > > Are you checking BZ 844344 scenario here? > Please check with the original scenario described in this bug this is not the same bug. Haim added a second host which is connected to a different pool. this is a normal migration between hosts who are in the same pool - no connection.
http://gerrit.ovirt.org/#/c/7494/
fixed in commit: 7131e73
Created attachment 614336 [details] log and screen shot tested in si18 not seeing the vm's migration in task manager screen shot and log attached.
Created attachment 626832 [details] screen shots
conclusion: the tasks appear under the Non-operational host task which is currently part of the design. I disagree with the location and think it should be fixed fro future versions.
verified on si22.1