[ovirt-users] TR: HA/Live Migration problems
CABRIMOL Steven
steven.cabrimol at c-s.fr
Tue Jun 13 15:13:47 UTC 2017
_____
De : CABRIMOL Steven [mailto:steven.cabrimol at c-s.fr]
Envoyé : mardi 13 juin 2017 17:06
À : 'users at ovirt.org'
Objet : HA/Live Migration problems
Hi guys,
I do not know if it’s the right place to ask, but it seems you don’t have
any user forum, so :
I just install O’virt and all the basics functions seems to be ok BUT I
can’t do Live migration, and HA is just reboot my host but not the VM’s.
Features Working :
2x Hypervisors : power management is ok
2x DATA STORAGE : VM storage and Hosted-engine storage
1x Cluster
2x Centos7 VM : guest-agent install
* I can do cold migration on both hypervisor.
* The two hypervisor see the storage
I maybe/surely miss something
. ( I don’t found any real how-to for my type
of infra)
PS : Just now it work on one side FIFI to RIRI, but not on the other one
Hope you can help me, enjoy your day.
Bye
Log : ( engine.log)
2017-06-13 15:04:08,501+02 INFO
[org.ovirt.engine.core.bll.MigrateVmToServerCommand] (default task-8)
[37ac066c-6732-4817-99cc-87f954ad09d9] Lock Acquired to object
'EngineLock:{exclusiveLocks='[a5cf6fc3-17dc-45f2-b81f-cb9179df132b=<VM,
ACTION_TYPE_FAILED_VM_IS_BEING_MIGRATED$VmName HostedEngine>]',
sharedLocks='null'}'
2017-06-13 15:04:08,861+02 INFO
[org.ovirt.engine.core.bll.MigrateVmToServerCommand]
(org.ovirt.thread.pool-6-thread-22) [37ac066c-6732-4817-99cc-87f954ad09d9]
Running command: MigrateVmToServerCommand internal: false. Entities affected
: ID: a5cf6fc3-17dc-45f2-b81f-cb9179df132b Type: VMAction group MIGRATE_VM
with role type USER
2017-06-13 15:04:09,234+02 INFO
[org.ovirt.engine.core.vdsbroker.MigrateVDSCommand]
(org.ovirt.thread.pool-6-thread-22) [37ac066c-6732-4817-99cc-87f954ad09d9]
START, MigrateVDSCommand( MigrateVDSCommandParameters:{runAsync='true',
hostId='f5523fc0-be7b-4097-a987-bc1902acab84',
vmId='a5cf6fc3-17dc-45f2-b81f-cb9179df132b', srcHost='fifi',
dstVdsId='87e118d8-5331-4b5e-8fd1-c5e7ef91e687',
dstHost='172.17.74.216:54321', migrationMethod='ONLINE',
tunnelMigration='false', migrationDowntime='0', autoConverge='false',
migrateCompressed='false', consoleAddress='null', maxBandwidth='50',
enableGuestEvents='false', maxIncomingMigrations='2',
maxOutgoingMigrations='2', convergenceSchedule='null'}), log id: 1abe8132
2017-06-13 15:04:09,234+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateBrokerVDSCommand]
(org.ovirt.thread.pool-6-thread-22) [37ac066c-6732-4817-99cc-87f954ad09d9]
START, MigrateBrokerVDSCommand(HostName = fifi,
MigrateVDSCommandParameters:{runAsync='true',
hostId='f5523fc0-be7b-4097-a987-bc1902acab84',
vmId='a5cf6fc3-17dc-45f2-b81f-cb9179df132b', srcHost='fifi',
dstVdsId='87e118d8-5331-4b5e-8fd1-c5e7ef91e687',
dstHost='172.17.74.216:54321', migrationMethod='ONLINE',
tunnelMigration='false', migrationDowntime='0', autoConverge='false',
migrateCompressed='false', consoleAddress='null', maxBandwidth='50',
enableGuestEvents='false', maxIncomingMigrations='2',
maxOutgoingMigrations='2', convergenceSchedule='null'}), log id: 1a2a6cdc
2017-06-13 15:04:10,068+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateBrokerVDSCommand]
(org.ovirt.thread.pool-6-thread-22) [37ac066c-6732-4817-99cc-87f954ad09d9]
FINISH, MigrateBrokerVDSCommand, log id: 1a2a6cdc
2017-06-13 15:04:10,084+02 INFO
[org.ovirt.engine.core.vdsbroker.MigrateVDSCommand]
(org.ovirt.thread.pool-6-thread-22) [37ac066c-6732-4817-99cc-87f954ad09d9]
FINISH, MigrateVDSCommand, return: MigratingFrom, log id: 1abe8132
2017-06-13 15:04:10,127+02 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(org.ovirt.thread.pool-6-thread-22) [37ac066c-6732-4817-99cc-87f954ad09d9]
EVENT_ID: VM_MIGRATION_START(62), Correlation ID:
37ac066c-6732-4817-99cc-87f954ad09d9, Job ID:
d625be6c-f91f-4200-accc-3cf4a0e5aa77, Call Stack: null, Custom Event ID: -1,
Message: Migration started (VM: HostedEngine, Source: fifi, Destination:
RIRI, User: admin at internal-authz).
2017-06-13 15:04:15,219+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher]
(DefaultQuartzScheduler1) [] Fetched 2 VMs from VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'
2017-06-13 15:04:15,223+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:04:15,223+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:04:30,525+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:04:30,525+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:04:46,070+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:04:46,070+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:05:02,321+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler7) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:05:02,321+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler7) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:05:17,377+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:05:17,377+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:05:32,417+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:05:32,417+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:05:47,706+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:05:47,707+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:06:04,346+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:06:04,346+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:06:19,940+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler6) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:06:19,941+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler6) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:06:35,350+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler2) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:06:35,350+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler2) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:06:50,395+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler2) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:06:50,395+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler2) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:07:05,444+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler2) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:07:05,444+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler2) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:07:21,697+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:07:21,697+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:07:39,187+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:07:39,188+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:07:54,324+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler7) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:07:54,324+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler7) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:08:09,435+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:08:09,435+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:08:25,903+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'MigratingTo' on VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:08:25,903+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler1) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 15:08:31,980+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(ForkJoinPool-1-worker-7) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' was
reported as Down on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI)
2017-06-13 15:08:31,982+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(ForkJoinPool-1-worker-7) [] START, DestroyVDSCommand(HostName = RIRI,
DestroyVmVDSCommandParameters:{runAsync='true',
hostId='87e118d8-5331-4b5e-8fd1-c5e7ef91e687',
vmId='a5cf6fc3-17dc-45f2-b81f-cb9179df132b', force='false',
secondsToWait='0', gracefully='false', reason='', ignoreNoVm='true'}), log
id: 12dc06bb
2017-06-13 15:08:33,355+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(ForkJoinPool-1-worker-7) [] Failed to destroy VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' because VM does not exist, ignoring
2017-06-13 15:08:33,355+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(ForkJoinPool-1-worker-7) [] FINISH, DestroyVDSCommand, log id: 12dc06bb
2017-06-13 15:08:33,356+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(ForkJoinPool-1-worker-7) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'Down' on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI)
(expected on 'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 15:08:35,626+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler7) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) moved from
'MigratingFrom' --> 'Up'
2017-06-13 15:08:35,626+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler7) [] Adding VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) to re-run list
2017-06-13 15:08:35,897+02 ERROR
[org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring]
(DefaultQuartzScheduler7) [] Rerun VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'. Called from VDS 'fifi'
2017-06-13 15:08:36,007+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateStatusVDSCommand]
(org.ovirt.thread.pool-6-thread-40) [] START,
MigrateStatusVDSCommand(HostName = fifi,
MigrateStatusVDSCommandParameters:{runAsync='true',
hostId='f5523fc0-be7b-4097-a987-bc1902acab84',
vmId='a5cf6fc3-17dc-45f2-b81f-cb9179df132b'}), log id: e3a2d40
2017-06-13 15:08:37,017+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateStatusVDSCommand]
(org.ovirt.thread.pool-6-thread-40) [] FINISH, MigrateStatusVDSCommand, log
id: e3a2d40
2017-06-13 15:08:37,065+02 ERROR
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(org.ovirt.thread.pool-6-thread-40) [] EVENT_ID:
VM_MIGRATION_TO_SERVER_FAILED(120), Correlation ID:
37ac066c-6732-4817-99cc-87f954ad09d9, Job ID:
d625be6c-f91f-4200-accc-3cf4a0e5aa77, Call Stack: null, Custom Event ID: -1,
Message: Migration failed (VM: HostedEngine, Source: fifi, Destination:
RIRI).
2017-06-13 15:08:37,086+02 INFO
[org.ovirt.engine.core.bll.MigrateVmToServerCommand]
(org.ovirt.thread.pool-6-thread-40) [] Lock freed to object
'EngineLock:{exclusiveLocks='[a5cf6fc3-17dc-45f2-b81f-cb9179df132b=<VM,
ACTION_TYPE_FAILED_VM_IS_BEING_MIGRATED$VmName HostedEngine>]',
sharedLocks='null'}'
2017-06-13 15:08:40,955+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher]
(DefaultQuartzScheduler10) [] Fetched 1 VMs from VDS
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687'
2017-06-13 15:10:07,333+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(ForkJoinPool-1-worker-9) [] VM 'a5cf6fc3-17dc-45f2-b81f-cb9179df132b' was
reported as Down on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI)
2017-06-13 15:10:07,334+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(ForkJoinPool-1-worker-9) [] START, DestroyVDSCommand(HostName = RIRI,
DestroyVmVDSCommandParameters:{runAsync='true',
hostId='87e118d8-5331-4b5e-8fd1-c5e7ef91e687',
vmId='a5cf6fc3-17dc-45f2-b81f-cb9179df132b', force='false',
secondsToWait='0', gracefully='false', reason='', ignoreNoVm='true'}), log
id: b2388b7
2017-06-13 15:10:08,482+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(ForkJoinPool-1-worker-9) [] FINISH, DestroyVDSCommand, log id: b2388b7
2017-06-13 15:10:08,482+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(ForkJoinPool-1-worker-9) [] VM
'a5cf6fc3-17dc-45f2-b81f-cb9179df132b'(HostedEngine) was unexpectedly
detected as 'Down' on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI)
(expected on 'f5523fc0-be7b-4097-a987-bc1902acab84')
LOG migration ok FIFI to RIRI
2017-06-13 16:45:40,555+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM
'c6c3f049-ae61-4227-839e-9f70d29e910b'(VM-RIRI) was unexpectedly detected as
'MigratingTo' on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected
on 'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 16:45:40,556+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM 'c6c3f049-ae61-4227-839e-9f70d29e910b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 16:45:56,565+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM
'c6c3f049-ae61-4227-839e-9f70d29e910b'(VM-RIRI) was unexpectedly detected as
'MigratingTo' on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected
on 'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 16:45:56,565+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler9) [] VM 'c6c3f049-ae61-4227-839e-9f70d29e910b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 16:46:12,037+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler3) [] VM
'c6c3f049-ae61-4227-839e-9f70d29e910b'(VM-RIRI) was unexpectedly detected as
'MigratingTo' on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected
on 'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 16:46:12,038+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler3) [] VM 'c6c3f049-ae61-4227-839e-9f70d29e910b' is
migrating to VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) ignoring it in
the refresh until migration is done
2017-06-13 16:46:22,993+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(ForkJoinPool-1-worker-13) [] VM
'c6c3f049-ae61-4227-839e-9f70d29e910b'(VM-RIRI) was unexpectedly detected as
'Up' on VDS '87e118d8-5331-4b5e-8fd1-c5e7ef91e687'(RIRI) (expected on
'f5523fc0-be7b-4097-a987-bc1902acab84')
2017-06-13 16:46:23,101+02 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(ForkJoinPool-1-worker-13) [] EVENT_ID: VM_MIGRATION_DONE(63), Correlation
ID: 3ca17cc1-fed4-48a7-a23e-fc3ac8494041, Job ID:
9f6863d5-08c0-4e4d-a809-4a2d2282ddbc, Call Stack: null, Custom Event ID: -1,
Message: Migration completed (VM: VM-RIRI, Source: fifi, Destination: RIRI,
Duration: 1 minute 32 seconds, Total: 1 minute 32 seconds, Actual downtime:
169ms)
2017-06-13 16:46:23,119+02 INFO
[org.ovirt.engine.core.bll.MigrateVmCommand] (ForkJoinPool-1-worker-13) []
Lock freed to object
'EngineLock:{exclusiveLocks='[c6c3f049-ae61-4227-839e-9f70d29e910b=<VM,
ACTION_TYPE_FAILED_VM_IS_BEING_MIGRATED$VmName VM-RIRI>]',
sharedLocks='null'}'
2017-06-13 16:46:23,120+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand]
(ForkJoinPool-1-worker-13) [] START, FullListVDSCommand(HostName = RIRI,
FullListVDSCommandParameters:{runAsync='true',
hostId='87e118d8-5331-4b5e-8fd1-c5e7ef91e687',
vmIds='[c6c3f049-ae61-4227-839e-9f70d29e910b]'}), log id: 7d4624e8
2017-06-13 16:46:23,138+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand]
(ForkJoinPool-1-worker-13) [] FINISH, FullListVDSCommand, return:
[{acpiEnable=true, emulatedMachine=pc-i440fx-rhel7.3.0,
afterMigrationStatus=, pid=7672, memGuaranteedSize=2048,
transparentHugePages=true, timeOffset=0, cpuType=SandyBridge, smp=1,
guestNumaNodes=[Ljava.lang.Object;@260ce3e2, smartcardEnable=false,
custom={device_bbf0e81a-d9a5-40a4-a938-7f19c2b172f3=VmDevice:{id='VmDeviceId
:{deviceId='bbf0e81a-d9a5-40a4-a938-7f19c2b172f3',
vmId='c6c3f049-ae61-4227-839e-9f70d29e910b'}', device='ide',
type='CONTROLLER', bootOrder='0', specParams='[]', address='{slot=0x01,
bus=0x00, domain=0x0000, type=pci, function=0x1}', managed='false',
plugged='true', readOnly='false', deviceAlias='ide', customProperties='[]',
snapshotId='null', logicalName='null', hostDevice='null'},
device_bbf0e81a-d9a5-40a4-a938-7f19c2b172f3device_08c7d5ca-049b-456e-8fdd-8b
3bb6718d2adevice_9864e069-930b-49c3-aef2-6f297f6f67ce=VmDevice:{id='VmDevice
Id:{deviceId='9864e069-930b-49c3-aef2-6f297f6f67ce',
vmId='c6c3f049-ae61-4227-839e-9f70d29e910b'}', device='unix',
type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0,
controller=0, type=virtio-serial, port=2}', managed='false', plugged='true',
readOnly='false', deviceAlias='channel1', customProperties='[]',
snapshotId='null', logicalName='null', hostDevice='null'},
device_bbf0e81a-d9a5-40a4-a938-7f19c2b172f3device_08c7d5ca-049b-456e-8fdd-8b
3bb6718d2adevice_9864e069-930b-49c3-aef2-6f297f6f67cedevice_28ac518a-f30a-4c
77-9033-dbf664d8b294=VmDevice:{id='VmDeviceId:{deviceId='28ac518a-f30a-4c77-
9033-dbf664d8b294', vmId='c6c3f049-ae61-4227-839e-9f70d29e910b'}',
device='spicevmc', type='CHANNEL', bootOrder='0', specParams='[]',
address='{bus=0, controller=0, type=virtio-serial, port=3}',
managed='false', plugged='true', readOnly='false', deviceAlias='channel2',
customProperties='[]', snapshotId='null', logicalName='null',
hostDevice='null'},
device_bbf0e81a-d9a5-40a4-a938-7f19c2b172f3device_08c7d5ca-049b-456e-8fdd-8b
3bb6718d2a=VmDevice:{id='VmDeviceId:{deviceId='08c7d5ca-049b-456e-8fdd-8b3bb
6718d2a', vmId='c6c3f049-ae61-4227-839e-9f70d29e910b'}', device='unix',
type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0,
controller=0, type=virtio-serial, port=1}', managed='false', plugged='true',
readOnly='false', deviceAlias='channel0', customProperties='[]',
snapshotId='null', logicalName='null', hostDevice='null'}}, vmType=kvm,
memSize=2048, smpCoresPerSocket=1, vmName=VM-RIRI, nice=0, status=Up,
maxMemSize=8192, bootMenuEnable=true,
vmId=c6c3f049-ae61-4227-839e-9f70d29e910b, smpThreadsPerCore=1,
guestDiskMapping={}, maxMemSlots=16, kvmEnable=true,
displayNetwork=ovirtmgmt, devices=[Ljava.lang.Object;@2e2fc0fa, maxVCpus=16,
clientIp=, statusTime=4372160030, display=qxl}], log id: 7d4624e8
2017-06-13 16:46:23,146+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmDevicesMonitoring]
(ForkJoinPool-1-worker-13) [] Received a spice Device without an address
when processing VM c6c3f049-ae61-4227-839e-9f70d29e910b devices, skipping
device: {device=spice, specParams={fileTransferEnable=true,
displayNetwork=ovirtmgmt,
spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,ssmartc
ard,susbredir, displayIp=172.17.74.216, copyPasteEnable=true},
type=graphics, deviceId=84364ae9-1984-4d24-bc5b-aa3969502205, tlsPort=5900}
2017-06-13 16:46:23,244+02 INFO
[org.ovirt.engine.core.bll.VmSlaPolicyCommand]
(org.ovirt.thread.pool-6-thread-38) [6ab21bc6] Running command:
VmSlaPolicyCommand internal: true. Entities affected : ID:
c6c3f049-ae61-4227-839e-9f70d29e910b Type: VMAction group EDIT_VM_PROPERTIES
with role type USER
2017-06-13 16:46:23,245+02 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmPolicyVDSCommand]
(org.ovirt.thread.pool-6-thread-38) [6ab21bc6] START,
UpdateVmPolicyVDSCommand(HostName = RIRI,
UpdateVmPolicyVDSParams:{runAsync='true',
hostId='87e118d8-5331-4b5e-8fd1-c5e7ef91e687',
vmId='c6c3f049-ae61-4227-839e-9f70d29e910b'}), log id: 12ae92d2
2017-06-13 16:46:24,250+02 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmPolicyVDSCommand]
(org.ovirt.thread.pool-6-thread-38) [6ab21bc6] FINISH,
UpdateVmPolicyVDSCommand, log id: 12ae92d2
2017-06-13 16:46:24,326+02 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(org.ovirt.thread.pool-6-thread-38) [6ab21bc6] EVENT_ID:
VM_SLA_POLICY_CPU(10,550), Correlation ID: 6ab21bc6, Call Stack: null,
Custom Event ID: -1, Message: VM VM-RIRI SLA Policy was set. CPU limit is
set to 10
2017-06-13 16:46:29,942+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler4) [] VM 'c6c3f049-ae61-4227-839e-9f70d29e910b' was
reported as Down on VDS 'f5523fc0-be7b-4097-a987-bc1902acab84'(fifi)
2017-06-13 16:46:29,943+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(DefaultQuartzScheduler4) [] START, DestroyVDSCommand(HostName = fifi,
DestroyVmVDSCommandParameters:{runAsync='true',
hostId='f5523fc0-be7b-4097-a987-bc1902acab84',
vmId='c6c3f049-ae61-4227-839e-9f70d29e910b', force='false',
secondsToWait='0', gracefully='false', reason='', ignoreNoVm='true'}), log
id: 4666101e
2017-06-13 16:46:31,175+02 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(DefaultQuartzScheduler4) [] FINISH, DestroyVDSCommand, log id: 4666101e
2017-06-13 16:46:31,175+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(DefaultQuartzScheduler4) [] VM
'c6c3f049-ae61-4227-839e-9f70d29e910b'(VM-RIRI) was unexpectedly detected as
'Down' on VDS 'f5523fc0-be7b-4097-a987-bc1902acab84'(fifi) (expected on
'87e118d8-5331-4b5e-8fd1-c5e7ef91e687')
2017-06-13 16:46:48,001+02 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher]
(DefaultQuartzScheduler2) [] Fetched 2 VMs from VDS
'f5523fc0-be7b-4097-a987-bc1902acab84'
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20170613/c130c300/attachment-0001.html>
More information about the Users
mailing list